[61.295865] Initializing watchdogs
[61.295927]   /dev/watchdog0
[61.315276] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:03:00.0: 8086:56a0 Intel Dg2 (Gen12) DG2 [Arc A770]
[61.325638] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[61.329557] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[61.332294] [001/133] (960s left) kms_color (ctm-0-25)
[61.512607] Starting subtest: ctm-0-25
[61.513481] Starting dynamic subtest: pipe-A-DP-3
[63.320398] Dynamic subtest pipe-A-DP-3: SUCCESS (1.809s)
[63.331538] Starting dynamic subtest: pipe-B-DP-3
[64.967898] Dynamic subtest pipe-B-DP-3: SUCCESS (1.648s)
[64.978970] Starting dynamic subtest: pipe-C-DP-3
[66.624329] Dynamic subtest pipe-C-DP-3: SUCCESS (1.657s)
[66.633030] Starting dynamic subtest: pipe-D-DP-3
[68.082653] Dynamic subtest pipe-D-DP-3: SUCCESS (1.459s)
[68.083641] Subtest ctm-0-25: SUCCESS (6.575s)
[68.395409] [002/133] (953s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-mmap-cpu)
[68.583226] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-mmap-cpu
[68.584935] Subtest fbc-2p-scndscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[68.777045] [003/133] (953s left) gem_exec_balancer (noheartbeat)
[69.166280] Starting subtest: noheartbeat
[69.168147] Subtest noheartbeat: SKIP (0.000s)
[69.312907] [004/133] (952s left) kms_cursor_legacy (cursorb-vs-flipb-atomic-transitions)
[69.491900] Starting subtest: cursorB-vs-flipB-atomic-transitions
[69.493544] Subtest cursorB-vs-flipB-atomic-transitions: SKIP (0.001s)
[69.655992] [005/133] (952s left) kms_busy (extended-pageflip-hang-oldfb)
[69.844314] Starting subtest: extended-pageflip-hang-oldfb
[69.846047] Starting dynamic subtest: pipe-A
[70.104450] Dynamic subtest pipe-A: SUCCESS (0.258s)
[70.124918] Starting dynamic subtest: pipe-D
[70.359103] Dynamic subtest pipe-D: SUCCESS (0.248s)
[70.360064] Subtest extended-pageflip-hang-oldfb: SUCCESS (0.515s)
[70.656525] [006/133] (951s left) kms_draw_crc (draw-method-mmap-wc)
[70.831899] Starting subtest: draw-method-mmap-wc
[70.833519] Subtest draw-method-mmap-wc: SKIP (0.000s)
[71.028556] [007/133] (951s left) kms_content_protection (uevent)
[71.275249] Starting subtest: uevent
[71.299408] Starting dynamic subtest: pipe-A-DP-3
[105.495230] Dynamic subtest pipe-A-DP-3: FAIL (34.151s)
[105.555135] Subtest uevent: FAIL (34.283s)
[105.874215] [008/133] (916s left) kms_cursor_crc (cursor-rapid-movement-32x32)
[106.146498] Starting subtest: cursor-rapid-movement-32x32
[106.197828] Subtest cursor-rapid-movement-32x32: SKIP (0.049s)
[106.641450] [009/133] (915s left) gem_render_copy (y-tiled-ccs-to-y-tiled-ccs)
[106.720525] Starting subtest: y-tiled-ccs-to-y-tiled-ccs
[106.722416] Subtest y-tiled-ccs-to-y-tiled-ccs: SKIP (0.000s)
[106.969715] [010/133] (915s left) gem_exec_fence (syncobj-import)
[107.551798] Starting subtest: syncobj-import
[107.585260] Subtest syncobj-import: SUCCESS (0.033s)
[108.018599] [FACT gem_exec_fence (syncobj-import)] new: kernel.kmod_is_loaded.vgem: true
[108.020556] [011/133] (914s left) gem_exec_flush (basic-wb-pro-default)
[108.106369] Subtest basic-wb-pro-default: SKIP (0.000s)
[108.189934] [012/133] (914s left) gem_exec_schedule (preempt-other)
[108.282679] Starting subtest: preempt-other
[108.283569] Starting dynamic subtest: rcs0
[108.838296] Dynamic subtest rcs0: SUCCESS (0.555s)
[108.846736] Starting dynamic subtest: bcs0
[109.368032] Dynamic subtest bcs0: SUCCESS (0.529s)
[109.376898] Starting dynamic subtest: vcs0
[109.913143] Dynamic subtest vcs0: SUCCESS (0.545s)
[109.922295] Starting dynamic subtest: vcs1
[110.442435] Dynamic subtest vcs1: SUCCESS (0.529s)
[110.450751] Starting dynamic subtest: vecs0
[110.966352] Dynamic subtest vecs0: SUCCESS (0.524s)
[110.975246] Starting dynamic subtest: vecs1
[111.492341] Dynamic subtest vecs1: SUCCESS (0.526s)
[111.501346] Starting dynamic subtest: ccs0
[112.182581] Dynamic subtest ccs0: SUCCESS (0.690s)
[112.183654] Subtest preempt-other: SUCCESS (3.900s)
[112.571099] [013/133] (910s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-blt)
[112.762305] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-blt
[112.763984] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[112.932931] [014/133] (909s left) gem_fence_thrash (bo-write-verify-threaded-y)
[112.978373] Starting subtest: bo-write-verify-threaded-y
[113.009011] Subtest bo-write-verify-threaded-y: SKIP (0.030s)
[113.103230] [015/133] (909s left) kms_addfb_basic (invalid-set-prop-any)
[113.182009] Starting subtest: invalid-set-prop-any
[113.182950] Subtest invalid-set-prop-any: SUCCESS (0.000s)
[113.466245] [016/133] (909s left) gem_pxp (reject-modify-context-protection-off-3)
[116.072904] Starting subtest: reject-modify-context-protection-off-3
[116.074768] Subtest reject-modify-context-protection-off-3: SKIP (0.000s)
[116.187272] [017/133] (906s left) gem_exec_schedule (fairslice-all)
[116.279377] Starting subtest: fairslice-all
[118.403248] Subtest fairslice-all: SUCCESS (2.124s)
[118.860572] [018/133] (904s left) kms_chamelium_edid (dp-mode-timings)
[119.122398] Subtest dp-mode-timings: SKIP (0.000s)
[119.270428] [019/133] (903s left) kms_ccs (crc-primary-rotation-180-4-tiled-mtl-mc-ccs)
[119.453360] Starting subtest: crc-primary-rotation-180-4-tiled-mtl-mc-ccs
[119.454259] Starting dynamic subtest: pipe-A-DP-3
[119.462411] Dynamic subtest pipe-A-DP-3: SKIP (0.001s)
[119.470940] Starting dynamic subtest: pipe-B-DP-3
[119.479122] Dynamic subtest pipe-B-DP-3: SKIP (0.001s)
[119.487417] Starting dynamic subtest: pipe-C-DP-3
[119.495538] Dynamic subtest pipe-C-DP-3: SKIP (0.001s)
[119.503867] Starting dynamic subtest: pipe-D-DP-3
[119.513084] Dynamic subtest pipe-D-DP-3: SKIP (0.001s)
[119.515171] Subtest crc-primary-rotation-180-4-tiled-mtl-mc-ccs: SKIP (0.006s)
[119.905663] [020/133] (903s left) gem_ctx_param (invalid-get-no-zeromap)
[119.982367] Starting subtest: invalid-get-no-zeromap
[119.984218] Subtest invalid-get-no-zeromap: SUCCESS (0.001s)
[120.189684] [021/133] (903s left) kms_frontbuffer_tracking (psr-1p-primscrn-indfb-msflip-blt)
[120.381483] Starting subtest: psr-1p-primscrn-indfb-msflip-blt
[120.383148] Subtest psr-1p-primscrn-indfb-msflip-blt: SKIP (0.000s)
[120.574667] [022/133] (902s left) i915_pm_rps (thresholds-idle)
[120.659799] Starting subtest: thresholds-idle
[120.661639] Subtest thresholds-idle: SKIP (0.000s)
[120.840362] [023/133] (902s left) gem_close (many-handles-one-vma)
[120.922297] Starting subtest: many-handles-one-vma
[120.951753] Subtest many-handles-one-vma: SUCCESS (0.029s)
[121.134486] [024/133] (902s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-shrfb-msflip-blt)
[121.320642] Starting subtest: fbcpsr-2p-primscrn-shrfb-msflip-blt
[121.322288] Subtest fbcpsr-2p-primscrn-shrfb-msflip-blt: SKIP (0.000s)
[121.465796] [025/133] (902s left) kms_chamelium_hpd (hdmi-hpd-with-enabled-mode)
[121.737559] Subtest hdmi-hpd-with-enabled-mode: SKIP (0.000s)
[121.891202] [026/133] (901s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-0-hflip)
[122.090847] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-0-hflip
[122.092900] Subtest y-tiled-max-hw-stride-32bpp-rotate-0-hflip: SKIP (0.000s)
[122.283976] [027/133] (901s left) gem_mmap_offset (clear-via-pagefault)
[122.362936] Starting subtest: clear-via-pagefault
[122.364459] Starting dynamic subtest: lmem0
[148.833427] Dynamic subtest lmem0: SUCCESS (26.467s)
[148.842492] Starting dynamic subtest: smem0
[170.703279] Dynamic subtest smem0: SUCCESS (21.870s)
[170.704182] Subtest clear-via-pagefault: SUCCESS (48.339s)
[171.182498] [028/133] (852s left) kms_pipe_b_c_ivb (disable-pipe-b-enable-pipe-c)
[171.262861] Subtest disable-pipe-B-enable-pipe-C: SKIP (0.000s)
[171.344114] [029/133] (852s left) kms_psr (pr-sprite-render)
[171.531576] Subtest pr-sprite-render: SKIP (0.000s)
[171.594693] [030/133] (852s left) gem_exec_reloc (basic-cpu-read-noreloc)
[171.680132] Subtest basic-cpu-read-noreloc: SKIP (0.000s)
[171.744621] [031/133] (852s left) kms_setmode (basic-clone-single-crtc)
[171.821983] Starting subtest: basic-clone-single-crtc
[171.824918] Subtest basic-clone-single-crtc: SKIP (0.000s)
[171.977737] [032/133] (851s left) gem_exec_alignment (pi-isolated)
[172.062194] Starting subtest: pi-isolated
[188.819802] Subtest pi-isolated: SUCCESS (16.756s)
[189.349338] [033/133] (834s left) gem_ctx_persistence (heartbeat-hang)
[189.487477] Starting subtest: heartbeat-hang
[189.489417] Subtest heartbeat-hang: SKIP (0.000s)
[189.663528] [034/133] (834s left) kms_display_modes (extended-mode-basic)
[189.857271] Starting subtest: extended-mode-basic
[189.860068] Subtest extended-mode-basic: SKIP (0.000s)
[189.912420] [035/133] (834s left) kms_plane (plane-position-hole)
[190.104347] Starting subtest: plane-position-hole
[190.549195] Starting dynamic subtest: pipe-A-plane-1
[191.014145] Dynamic subtest pipe-A-plane-1: SUCCESS (0.465s)
[191.026486] Starting dynamic subtest: pipe-A-plane-2
[191.475204] Dynamic subtest pipe-A-plane-2: SUCCESS (0.460s)
[191.487219] Starting dynamic subtest: pipe-A-plane-3
[191.931879] Dynamic subtest pipe-A-plane-3: SUCCESS (0.457s)
[191.943486] Starting dynamic subtest: pipe-A-plane-4
[192.360591] Dynamic subtest pipe-A-plane-4: SUCCESS (0.428s)
[192.373682] Starting dynamic subtest: pipe-A-plane-5
[192.385304] Dynamic subtest pipe-A-plane-5: SUCCESS (0.024s)
[192.743632] Starting dynamic subtest: pipe-B-plane-1
[193.157331] Dynamic subtest pipe-B-plane-1: SUCCESS (0.423s)
[193.167130] Starting dynamic subtest: pipe-B-plane-2
[193.595438] Dynamic subtest pipe-B-plane-2: SUCCESS (0.437s)
[193.605124] Starting dynamic subtest: pipe-B-plane-3
[194.015354] Dynamic subtest pipe-B-plane-3: SUCCESS (0.419s)
[194.025138] Starting dynamic subtest: pipe-B-plane-4
[194.454486] Dynamic subtest pipe-B-plane-4: SUCCESS (0.440s)
[194.464426] Starting dynamic subtest: pipe-B-plane-5
[194.473584] Dynamic subtest pipe-B-plane-5: SUCCESS (0.019s)
[194.474421] Subtest plane-position-hole: SUCCESS (4.369s)
[194.776596] [036/133] (829s left) kms_pm_backlight (bad-brightness)
[194.961260] Subtest bad-brightness: SKIP (0.000s)
[195.053899] [037/133] (829s left) syncobj_timeline (multi-wait-available-unsubmitted-signaled)
[195.136427] Starting subtest: multi-wait-available-unsubmitted-signaled
[195.137288] Subtest multi-wait-available-unsubmitted-signaled: SUCCESS (0.001s)
[195.340749] [038/133] (829s left) kms_mmap_write_crc (main)
[195.530354] Starting subtest: main
[195.532289] Starting dynamic subtest: pipe-A-DP-3
[199.337448] Dynamic subtest pipe-A-DP-3: SUCCESS (3.806s)
[199.338471] Subtest main: SUCCESS (3.807s)
[199.679712] [039/133] (824s left) gem_spin_batch (resubmit-new-all)
[199.769761] Starting subtest: resubmit-new-all
[199.770647] Starting dynamic subtest: rcs0
[199.807236] Dynamic subtest rcs0: SUCCESS (0.037s)
[199.816956] Starting dynamic subtest: bcs0
[199.817894] Dynamic subtest bcs0: SUCCESS (0.008s)
[199.827465] Starting dynamic subtest: vcs0
[199.828366] Dynamic subtest vcs0: SUCCESS (0.008s)
[199.837951] Starting dynamic subtest: vcs1
[199.838892] Dynamic subtest vcs1: SUCCESS (0.010s)
[199.848637] Starting dynamic subtest: vecs0
[199.849458] Dynamic subtest vecs0: SUCCESS (0.009s)
[199.858982] Starting dynamic subtest: vecs1
[199.859925] Dynamic subtest vecs1: SUCCESS (0.007s)
[199.869432] Starting dynamic subtest: ccs0
[199.870554] Dynamic subtest ccs0: SUCCESS (0.009s)
[199.871520] Subtest resubmit-new-all: SUCCESS (0.092s)
[200.242510] [040/133] (824s left) kms_flip (flip-vs-rmfb-interruptible)
[200.434297] Starting subtest: flip-vs-rmfb-interruptible
[200.438868] Starting dynamic subtest: A-DP3
[208.268401] Dynamic subtest A-DP3: SUCCESS (7.829s)
[208.305246] Starting dynamic subtest: B-DP3
[216.010100] Dynamic subtest B-DP3: SUCCESS (7.738s)
[216.046071] Starting dynamic subtest: C-DP3
[223.752214] Dynamic subtest C-DP3: SUCCESS (7.738s)
[223.785768] Starting dynamic subtest: D-DP3
[231.494727] Dynamic subtest D-DP3: SUCCESS (7.738s)
[231.502934] Subtest flip-vs-rmfb-interruptible: SUCCESS (31.068s)
[231.887711] [041/133] (792s left) kms_rotation_crc (sprite-rotation-180)
[232.074596] Starting subtest: sprite-rotation-180
[242.323960] Subtest sprite-rotation-180: SUCCESS (10.248s)
[242.699949] [042/133] (782s left) gem_exec_alignment (single)
[242.784203] Starting subtest: single
[242.790629] Subtest single: SUCCESS (0.006s)
[242.963832] [043/133] (781s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-180-hflip)
[243.162259] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-180-hflip
[244.434196] Subtest x-tiled-max-hw-stride-32bpp-rotate-180-hflip: SUCCESS (1.270s)
[244.671620] [044/133] (780s left) kms_frontbuffer_tracking (psr-1p-primscrn-shrfb-plflip-blt)
[244.860875] Starting subtest: psr-1p-primscrn-shrfb-plflip-blt
[244.862524] Subtest psr-1p-primscrn-shrfb-plflip-blt: SKIP (0.000s)
[245.070125] [045/133] (779s left) syncobj_wait (invalid-signal-zero-handles)
[245.150361] Starting subtest: invalid-signal-zero-handles
[245.151285] Subtest invalid-signal-zero-handles: SUCCESS (0.000s)
[245.331336] [046/133] (779s left) kms_async_flips (alternate-sync-async-flip)
[245.517423] Starting subtest: alternate-sync-async-flip
[245.753737] Starting dynamic subtest: pipe-A-DP-3
[248.047688] Dynamic subtest pipe-A-DP-3: SUCCESS (2.294s)
[248.293502] Starting dynamic subtest: pipe-B-DP-3
[250.420691] Dynamic subtest pipe-B-DP-3: SUCCESS (2.137s)
[250.635049] Starting dynamic subtest: pipe-C-DP-3
[252.759602] Dynamic subtest pipe-C-DP-3: SUCCESS (2.134s)
[252.970066] Starting dynamic subtest: pipe-D-DP-3
[255.095219] Dynamic subtest pipe-D-DP-3: SUCCESS (2.134s)
[255.099610] Subtest alternate-sync-async-flip: SUCCESS (9.580s)
[255.649449] [047/133] (769s left) kms_frontbuffer_tracking (fbcpsr-1p-rte)
[255.843275] Starting subtest: fbcpsr-1p-rte
[255.845038] Subtest fbcpsr-1p-rte: SKIP (0.000s)
[256.049298] [048/133] (769s left) perf (gen12-group-exclusive-stream-ctx-handle)
[256.454362] Starting subtest: gen12-group-exclusive-stream-ctx-handle
[256.480394] Subtest gen12-group-exclusive-stream-ctx-handle: SUCCESS (0.027s)
[256.530733] [049/133] (768s left) gem_render_copy_redux (flink-interruptible)
[256.650403] Starting subtest: flink-interruptible
[259.793483] Subtest flink-interruptible: SUCCESS (3.143s)
[260.047921] [050/133] (765s left) gem_userptr_blits (probe)
[260.146275] Starting subtest: probe
[260.285116] Subtest probe: SUCCESS (0.117s)
[260.436068] [051/133] (764s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-shrfb-msflip-blt)
[260.626452] Starting subtest: fbc-2p-scndscrn-shrfb-msflip-blt
[260.628125] Subtest fbc-2p-scndscrn-shrfb-msflip-blt: SKIP (0.000s)
[260.842494] [052/133] (764s left) gem_lmem_swapping (heavy-verify-multi-ccs)
[263.653847] Starting subtest: heavy-verify-multi-ccs
[263.654669] Starting dynamic subtest: lmem0
[275.417966] Dynamic subtest lmem0: SUCCESS (11.764s)
[275.420332] Subtest heavy-verify-multi-ccs: SUCCESS (11.766s)
[276.662089] [FACT gem_lmem_swapping (heavy-verify-multi-ccs)] deleted: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[276.663092] [FACT gem_lmem_swapping (heavy-verify-multi-ccs)] deleted: kernel.kmod_is_loaded.i915: true
[276.665084] [053/133] (748s left) core_getclient (basic)
[278.260801] Starting subtest: basic
[278.261942] Subtest basic: SUCCESS (0.000s)
[278.321038] [FACT core_getclient (basic)] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[278.323811] [FACT core_getclient (basic)] new: kernel.kmod_is_loaded.i915: true
[278.327224] [054/133] (747s left) kms_cursor_crc (cursor-onscreen-128x128)
[278.724038] Starting subtest: cursor-onscreen-128x128
[278.739195] Starting dynamic subtest: pipe-A-DP-3
[281.408395] Dynamic subtest pipe-A-DP-3: SUCCESS (2.668s)
[281.454725] Starting dynamic subtest: pipe-D-DP-3
[284.135012] Dynamic subtest pipe-D-DP-3: SUCCESS (2.688s)
[284.135964] Subtest cursor-onscreen-128x128: SUCCESS (5.410s)
[284.619661] [055/133] (741s left) kms_plane_lowres (tiling-y)
[284.810582] Starting subtest: tiling-y
[284.812330] Subtest tiling-y: SKIP (0.000s)
[284.979825] [056/133] (740s left) api_intel_allocator (gem-pool)
[285.056326] Starting subtest: gem-pool
[285.091577] Subtest gem-pool: SUCCESS (0.035s)
[285.312121] [057/133] (740s left) i915_drm_fdinfo (isolation)
[285.387566] Starting subtest: isolation
[285.388432] Starting dynamic subtest: rcs0
[285.401247] Dynamic subtest rcs0: SKIP (0.014s)
[285.410683] Starting dynamic subtest: bcs0
[285.413987] Dynamic subtest bcs0: SKIP (0.011s)
[285.423606] Starting dynamic subtest: vcs0
[285.425841] Dynamic subtest vcs0: SKIP (0.000s)
[285.435171] Starting dynamic subtest: vcs1
[285.437408] Dynamic subtest vcs1: SKIP (0.000s)
[285.446619] Starting dynamic subtest: vecs0
[285.448473] Dynamic subtest vecs0: SKIP (0.000s)
[285.457681] Starting dynamic subtest: vecs1
[285.459905] Dynamic subtest vecs1: SKIP (0.000s)
[285.469082] Starting dynamic subtest: ccs0
[285.471375] Dynamic subtest ccs0: SKIP (0.000s)
[285.473361] Subtest isolation: SKIP (0.034s)
[285.552867] [058/133] (740s left) gem_exec_parallel (basic)
[285.640979] Starting subtest: basic
[285.641978] Starting dynamic subtest: rcs0
[287.174515] Dynamic subtest rcs0: SUCCESS (1.533s)
[287.185460] Starting dynamic subtest: bcs0
[288.627180] Dynamic subtest bcs0: SUCCESS (1.451s)
[288.640659] Starting dynamic subtest: vcs0
[290.138310] Dynamic subtest vcs0: SUCCESS (1.510s)
[290.151187] Starting dynamic subtest: vcs1
[291.623416] Dynamic subtest vcs1: SUCCESS (1.484s)
[291.635681] Starting dynamic subtest: vecs0
[293.117493] Dynamic subtest vecs0: SUCCESS (1.493s)
[293.129421] Starting dynamic subtest: vecs1
[294.586229] Dynamic subtest vecs1: SUCCESS (1.467s)
[294.599601] Starting dynamic subtest: ccs0
[296.032284] Dynamic subtest ccs0: SUCCESS (1.445s)
[296.033313] Subtest basic: SUCCESS (10.392s)
[296.380896] [059/133] (729s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-mmap-cpu)
[296.570838] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-mmap-cpu
[296.572454] Subtest fbc-2p-scndscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[296.760365] [060/133] (729s left) kms_getfb (getfb-handle-valid)
[296.944919] Starting subtest: getfb-handle-valid
[296.945856] Subtest getfb-handle-valid: SUCCESS (0.000s)
[297.145993] [061/133] (728s left) perf (invalid-remove-userspace-config)
[297.520754] Starting subtest: invalid-remove-userspace-config
[297.531394] Subtest invalid-remove-userspace-config: SUCCESS (0.009s)
[297.579484] [062/133] (728s left) kms_psr2_sf (pr-primary-plane-update-sf-dmg-area)
[297.770833] Subtest pr-primary-plane-update-sf-dmg-area: SKIP (0.000s)
[297.828248] [063/133] (728s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-mmap-cpu)
[298.020125] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-mmap-cpu
[298.021771] Subtest fbc-2p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[298.220249] [064/133] (728s left) kms_ccs (bad-rotation-90-4-tiled-dg2-rc-ccs-cc)
[298.409532] Starting subtest: bad-rotation-90-4-tiled-dg2-rc-ccs-cc
[298.411864] Starting dynamic subtest: pipe-A-DP-3
[298.420167] Dynamic subtest pipe-A-DP-3: SKIP (0.000s)
[298.429461] Starting dynamic subtest: pipe-B-DP-3
[298.437814] Dynamic subtest pipe-B-DP-3: SKIP (0.000s)
[298.447016] Starting dynamic subtest: pipe-C-DP-3
[298.455125] Dynamic subtest pipe-C-DP-3: SKIP (0.000s)
[298.464526] Starting dynamic subtest: pipe-D-DP-3
[298.475044] Dynamic subtest pipe-D-DP-3: SKIP (0.000s)
[298.477149] Subtest bad-rotation-90-4-tiled-dg2-rc-ccs-cc: SKIP (0.007s)
[298.896049] [065/133] (727s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-blt)
[299.094092] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-blt
[299.095677] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-blt: SKIP (0.000s)
[299.272646] [066/133] (727s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-indfb-msflip-blt)
[299.466045] Starting subtest: fbcpsr-2p-scndscrn-indfb-msflip-blt
[299.467799] Subtest fbcpsr-2p-scndscrn-indfb-msflip-blt: SKIP (0.000s)
[299.658413] [067/133] (726s left) kms_pm_rpm (cursor-dpms)
[302.074566] Starting subtest: cursor-dpms
[302.077908] Subtest cursor-dpms: SKIP (0.000s)
[302.513221] [068/133] (724s left) gem_ccs (block-multicopy-inplace)
[302.598238] Starting subtest: block-multicopy-inplace
[302.600402] Starting dynamic subtest: linear-compressed-compfmt0-smem-lmem0-multicopy
[302.642050] Dynamic subtest linear-compressed-compfmt0-smem-lmem0-multicopy: SUCCESS (0.043s)
[302.653118] Starting dynamic subtest: linear-compressed-compfmt0-lmem0-lmem0-multicopy
[302.741391] Dynamic subtest linear-compressed-compfmt0-lmem0-lmem0-multicopy: SUCCESS (0.098s)
[302.751980] Starting dynamic subtest: xmajor-compressed-compfmt0-smem-lmem0-multicopy
[302.756512] Dynamic subtest xmajor-compressed-compfmt0-smem-lmem0-multicopy: SUCCESS (0.014s)
[302.767490] Starting dynamic subtest: xmajor-compressed-compfmt0-lmem0-lmem0-multicopy
[302.858546] Dynamic subtest xmajor-compressed-compfmt0-lmem0-lmem0-multicopy: SUCCESS (0.101s)
[302.869221] Starting dynamic subtest: tile4-compressed-compfmt0-smem-lmem0-multicopy
[302.874388] Dynamic subtest tile4-compressed-compfmt0-smem-lmem0-multicopy: SUCCESS (0.014s)
[302.885254] Starting dynamic subtest: tile4-compressed-compfmt0-lmem0-lmem0-multicopy
[302.981271] Dynamic subtest tile4-compressed-compfmt0-lmem0-lmem0-multicopy: SUCCESS (0.106s)
[302.992292] Starting dynamic subtest: tile64-compressed-compfmt0-smem-lmem0-multicopy
[302.998267] Dynamic subtest tile64-compressed-compfmt0-smem-lmem0-multicopy: SUCCESS (0.016s)
[303.009111] Starting dynamic subtest: tile64-compressed-compfmt0-lmem0-lmem0-multicopy
[303.096927] Dynamic subtest tile64-compressed-compfmt0-lmem0-lmem0-multicopy: SUCCESS (0.098s)
[303.097853] Subtest block-multicopy-inplace: SUCCESS (0.499s)
[303.318342] [069/133] (723s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-0)
[303.511988] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-0
[303.513878] Subtest yf-tiled-max-hw-stride-64bpp-rotate-0: SKIP (0.000s)
[303.702947] [070/133] (723s left) kms_cursor_edge_walk (64x64-top-bottom)
[303.889914] Starting subtest: 64x64-top-bottom
[303.892128] Starting dynamic subtest: pipe-A-DP-3
[307.373619] Dynamic subtest pipe-A-DP-3: SUCCESS (3.481s)
[307.391122] Starting dynamic subtest: pipe-D-DP-3
[310.738207] Dynamic subtest pipe-D-DP-3: SUCCESS (3.361s)
[310.739367] Subtest 64x64-top-bottom: SUCCESS (6.848s)
[311.064028] [071/133] (715s left) syncobj_timeline (invalid-single-wait-all-unsubmitted)
[311.140333] Starting subtest: invalid-single-wait-all-unsubmitted
[311.141264] Subtest invalid-single-wait-all-unsubmitted: SUCCESS (0.000s)
[311.313814] [072/133] (715s left) gem_exec_capture (pi)
[311.399671] Starting subtest: pi
[311.400561] Starting dynamic subtest: rcs0
[317.431942] Dynamic subtest rcs0: SUCCESS (6.030s)
[317.441503] Starting dynamic subtest: bcs0
[323.238555] Dynamic subtest bcs0: SUCCESS (5.806s)
[323.248492] Starting dynamic subtest: vcs0
[329.037602] Dynamic subtest vcs0: SUCCESS (5.797s)
[329.048054] Starting dynamic subtest: vcs1
[334.810642] Dynamic subtest vcs1: SUCCESS (5.773s)
[334.820370] Starting dynamic subtest: vecs0
[340.594394] Dynamic subtest vecs0: SUCCESS (5.783s)
[340.604765] Starting dynamic subtest: vecs1
[346.594993] Dynamic subtest vecs1: SUCCESS (5.999s)
[346.604592] Starting dynamic subtest: ccs0
[352.432937] Dynamic subtest ccs0: SUCCESS (5.836s)
[352.433899] Subtest pi: SUCCESS (41.032s)
[352.611965] [073/133] (674s left) kms_plane (pixel-format-y-tiled-gen12-rc-ccs-cc-modifier-source-clamping)
[352.846680] Starting subtest: pixel-format-y-tiled-gen12-rc-ccs-cc-modifier-source-clamping
[352.848426] Subtest pixel-format-y-tiled-gen12-rc-ccs-cc-modifier-source-clamping: SKIP (0.000s)
[353.019420] [074/133] (674s left) kms_hdr (static-swap)
[353.208568] Starting subtest: static-swap
[356.873831] Starting dynamic subtest: pipe-A-DP-3
[358.101120] Dynamic subtest pipe-A-DP-3: SUCCESS (1.227s)
[358.103568] Subtest static-swap: SUCCESS (4.894s)
[358.444982] [075/133] (668s left) syncobj_wait (wait-for-submit-delayed-submit)
[358.531381] Starting subtest: wait-for-submit-delayed-submit
[358.633328] Subtest wait-for-submit-delayed-submit: SUCCESS (0.102s)
[358.794554] [076/133] (668s left) kms_vrr (flip-dpms)
[358.981394] Starting subtest: flip-dpms
[358.984043] Subtest flip-dpms: SKIP (0.000s)
[359.117199] [077/133] (668s left) kms_big_fb (linear-addfb)
[359.334243] Starting subtest: linear-addfb
[359.335346] Subtest linear-addfb: SUCCESS (0.000s)
[359.500738] [078/133] (667s left) kms_addfb_basic (addfb25-bad-modifier)
[359.702294] Starting subtest: addfb25-bad-modifier
[359.703208] Subtest addfb25-bad-modifier: SUCCESS (0.000s)
[359.907175] [079/133] (667s left) kms_psr (psr-sprite-plane-onoff)
[360.095456] Subtest psr-sprite-plane-onoff: SKIP (0.000s)
[360.156341] [080/133] (667s left) kms_psr (fbc-psr-sprite-plane-move)
[360.340531] Subtest fbc-psr-sprite-plane-move: SKIP (0.000s)
[360.406545] [081/133] (667s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-blt)
[360.603844] Starting subtest: fbcpsr-rgb101010-draw-blt
[360.605435] Subtest fbcpsr-rgb101010-draw-blt: SKIP (0.000s)
[360.797612] [082/133] (666s left) kms_prop_blob (invalid-get-prop)
[360.874555] Starting subtest: invalid-get-prop
[360.875435] Subtest invalid-get-prop: SUCCESS (0.000s)
[361.061578] [083/133] (666s left) sysfs_preempt_timeout (idempotent)
[361.154312] Starting subtest: idempotent
[361.156484] Starting dynamic subtest: vecs0
[361.157353] Dynamic subtest vecs0: SUCCESS (0.001s)
[361.166826] Starting dynamic subtest: ccs0
[361.167674] Dynamic subtest ccs0: SUCCESS (0.001s)
[361.177540] Starting dynamic subtest: vcs0
[361.178464] Dynamic subtest vcs0: SUCCESS (0.001s)
[361.188410] Starting dynamic subtest: bcs0
[361.189662] Dynamic subtest bcs0: SUCCESS (0.001s)
[361.199256] Starting dynamic subtest: vecs1
[361.200553] Dynamic subtest vecs1: SUCCESS (0.001s)
[361.210234] Starting dynamic subtest: rcs0
[361.211508] Dynamic subtest rcs0: SUCCESS (0.001s)
[361.220791] Starting dynamic subtest: vcs1
[361.221962] Dynamic subtest vcs1: SUCCESS (0.001s)
[361.223225] Subtest idempotent: SUCCESS (0.012s)
[361.297619] [084/133] (666s left) kms_psr (fbc-pr-primary-page-flip)
[361.488947] Subtest fbc-pr-primary-page-flip: SKIP (0.000s)
[361.555427] [085/133] (666s left) gem_exec_reloc (basic-gtt-active)
[361.646530] Subtest basic-gtt-active: SKIP (0.000s)
[361.724225] [086/133] (666s left) kms_chamelium_color (ctm-0-75)
[361.910519] Subtest ctm-0-75: SKIP (0.000s)
[361.996547] [087/133] (666s left) kms_flip_scaled_crc (flip-64bpp-linear-to-16bpp-linear-upscaling)
[362.181427] Starting subtest: flip-64bpp-linear-to-16bpp-linear-upscaling
[362.182303] Starting dynamic subtest: pipe-A-valid-mode
[364.027035] Dynamic subtest pipe-A-valid-mode: SUCCESS (1.843s)
[364.028458] Subtest flip-64bpp-linear-to-16bpp-linear-upscaling: SUCCESS (1.846s)
[364.308342] [088/133] (663s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-move)
[364.499211] Starting subtest: fbc-1p-primscrn-spr-indfb-move
[367.992566] Subtest fbc-1p-primscrn-spr-indfb-move: SUCCESS (3.494s)
[368.211259] [089/133] (659s left) kms_frontbuffer_tracking (psr-indfb-scaledprimary)
[368.402134] Starting subtest: psr-indfb-scaledprimary
[368.403827] Subtest psr-indfb-scaledprimary: SKIP (0.000s)
[368.607521] [090/133] (659s left) kms_big_fb (linear-max-hw-stride-64bpp-rotate-180-hflip)
[368.803302] Starting subtest: linear-max-hw-stride-64bpp-rotate-180-hflip
[368.805057] Subtest linear-max-hw-stride-64bpp-rotate-180-hflip: SKIP (0.000s)
[369.007986] [091/133] (659s left) syncobj_eventfd (timeline-wait)
[369.085480] Starting subtest: timeline-wait
[369.095933] Subtest timeline-wait: SUCCESS (0.010s)
[369.247100] [092/133] (659s left) gem_sync (basic-store-each)
[369.335530] Starting subtest: basic-store-each
[372.403821] Subtest basic-store-each: SUCCESS (3.068s)
[372.708203] [093/133] (655s left) core_getversion (all-cards)
[372.772265] Starting subtest: all-cards
[372.807121] Subtest all-cards: SUCCESS (0.036s)
[372.870045] [094/133] (655s left) gem_ctx_exec (basic-invalid-context)
[372.950376] Starting subtest: basic-invalid-context
[372.954982] Subtest basic-invalid-context: SUCCESS (0.004s)
[373.158510] [095/133] (655s left) kms_frontbuffer_tracking (fbc-1p-primscrn-shrfb-msflip-blt)
[373.347272] Starting subtest: fbc-1p-primscrn-shrfb-msflip-blt
[376.259675] Subtest fbc-1p-primscrn-shrfb-msflip-blt: SUCCESS (2.913s)
[376.507786] [096/133] (652s left) kms_prop_blob (blob-multiple)
[376.583426] Starting subtest: blob-multiple
[376.615271] Subtest blob-multiple: SUCCESS (0.032s)
[376.758340] [097/133] (652s left) kms_invalid_mode (zero-clock)
[376.956142] Starting subtest: zero-clock
[376.956999] Starting dynamic subtest: pipe-A-DP-3
[377.034239] Dynamic subtest pipe-A-DP-3: SUCCESS (0.078s)
[377.048463] Starting dynamic subtest: pipe-B-DP-3
[377.049641] Dynamic subtest pipe-B-DP-3: SUCCESS (0.001s)
[377.061895] Starting dynamic subtest: pipe-C-DP-3
[377.063176] Dynamic subtest pipe-C-DP-3: SUCCESS (0.001s)
[377.075332] Starting dynamic subtest: pipe-D-DP-3
[377.076287] Dynamic subtest pipe-D-DP-3: SUCCESS (0.001s)
[377.077266] Subtest zero-clock: SUCCESS (0.089s)
[377.325427] [098/133] (651s left) kms_flip_scaled_crc (flip-32bpp-4tile-to-64bpp-4tile-upscaling)
[377.518434] Starting subtest: flip-32bpp-4tile-to-64bpp-4tile-upscaling
[377.519338] Starting dynamic subtest: pipe-A-valid-mode
[380.070746] Dynamic subtest pipe-A-valid-mode: SUCCESS (2.551s)
[380.076083] Subtest flip-32bpp-4tile-to-64bpp-4tile-upscaling: SUCCESS (2.555s)
[380.378245] [099/133] (648s left) kms_ccs (random-ccs-data-4-tiled-dg2-rc-ccs)
[380.568386] Starting subtest: random-ccs-data-4-tiled-dg2-rc-ccs
[380.569239] Starting dynamic subtest: pipe-A-DP-3
[380.578339] Dynamic subtest pipe-A-DP-3: SKIP (0.000s)
[380.588699] Starting dynamic subtest: pipe-B-DP-3
[380.598489] Dynamic subtest pipe-B-DP-3: SKIP (0.000s)
[380.608302] Starting dynamic subtest: pipe-C-DP-3
[380.617253] Dynamic subtest pipe-C-DP-3: SKIP (0.000s)
[380.626574] Starting dynamic subtest: pipe-D-DP-3
[380.638100] Dynamic subtest pipe-D-DP-3: SKIP (0.000s)
[380.639659] Subtest random-ccs-data-4-tiled-dg2-rc-ccs: SKIP (0.007s)
[381.058380] [100/133] (647s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-mmap-gtt)
[381.247838] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-mmap-gtt
[381.249465] Subtest psr-2p-scndscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[381.415721] [101/133] (647s left) gem_tiled_wc
[381.573719] [102/133] (647s left) kms_universal_plane (universal-plane-sanity)
[381.757541] Starting subtest: universal-plane-sanity
[381.760079] Starting dynamic subtest: pipe-A-DP-3
[382.400500] Dynamic subtest pipe-A-DP-3: SUCCESS (0.641s)
[382.414142] Starting dynamic subtest: pipe-B-DP-3
[382.897410] Dynamic subtest pipe-B-DP-3: SUCCESS (0.494s)
[382.912307] Starting dynamic subtest: pipe-C-DP-3
[383.363405] Dynamic subtest pipe-C-DP-3: SUCCESS (0.463s)
[383.376170] Starting dynamic subtest: pipe-D-DP-3
[383.845717] Dynamic subtest pipe-D-DP-3: SUCCESS (0.480s)
[383.846595] Subtest universal-plane-sanity: SUCCESS (2.088s)
[384.154120] [103/133] (645s left) kms_plane_alpha_blend (alpha-opaque-fb)
[384.341264] Starting subtest: alpha-opaque-fb
[384.596690] Starting dynamic subtest: pipe-A-DP-3
[385.097415] Dynamic subtest pipe-A-DP-3: SUCCESS (0.500s)
[385.110308] Starting dynamic subtest: pipe-D-DP-3
[385.677757] Dynamic subtest pipe-D-DP-3: SUCCESS (0.578s)
[385.678564] Subtest alpha-opaque-fb: SUCCESS (1.337s)
[385.975486] [104/133] (643s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-mmap-gtt)
[386.163938] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-mmap-gtt
[386.165581] Subtest fbc-1p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[386.372839] [105/133] (643s left) kms_psr (psr2-primary-mmap-gtt)
[386.564383] Subtest psr2-primary-mmap-gtt: SKIP (0.000s)
[386.650426] [106/133] (642s left) gem_exec_schedule (semaphore-codependency)
[386.750163] Starting subtest: semaphore-codependency
[386.791367] Subtest semaphore-codependency: SUCCESS (0.041s)
[387.238128] [107/133] (642s left) gem_pread (bench)
[387.315185] Subtest bench: SKIP (0.000s)
[387.386434] [108/133] (642s left) drm_read (fault-buffer)
[387.644378] Starting subtest: fault-buffer
[387.645264] Subtest fault-buffer: SUCCESS (0.001s)
[387.907481] [109/133] (641s left) kms_frontbuffer_tracking (psr-2p-primscrn-shrfb-pgflip-blt)
[388.096904] Starting subtest: psr-2p-primscrn-shrfb-pgflip-blt
[388.098561] Subtest psr-2p-primscrn-shrfb-pgflip-blt: SKIP (0.000s)
[388.265973] [110/133] (641s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-render)
[388.466416] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-render
[388.468156] Subtest fbc-2p-scndscrn-pri-shrfb-draw-render: SKIP (0.000s)
[388.663714] [111/133] (641s left) gem_softpin (evict-snoop)
[388.751594] Starting subtest: evict-snoop
[388.753420] Subtest evict-snoop: SKIP (0.000s)
[388.883744] [112/133] (641s left) kms_getfb (getfb-handle-not-fb)
[389.068321] Starting subtest: getfb-handle-not-fb
[389.069226] Subtest getfb-handle-not-fb: SUCCESS (0.000s)
[389.273750] [113/133] (640s left) syncobj_timeline (wait-all-delayed-signal)
[389.351421] Starting subtest: wait-all-delayed-signal
[389.454667] Subtest wait-all-delayed-signal: SUCCESS (0.102s)
[389.585747] [114/133] (640s left) kms_atomic (plane-invalid-params-fence)
[389.771727] Starting subtest: plane-invalid-params-fence
[389.773847] Starting dynamic subtest: pipe-A-DP-3
[390.304832] Dynamic subtest pipe-A-DP-3: SUCCESS (0.514s)
[390.305885] Subtest plane-invalid-params-fence: SUCCESS (0.516s)
[390.590484] [115/133] (639s left) gem_mmap_gtt (coherency)
[390.668193] Subtest coherency: SKIP (0.000s)
[390.734287] [116/133] (639s left) prime_mmap (test_forked_cpu_write)
[390.810737] Starting subtest: test_forked_cpu_write
[390.811590] Starting dynamic subtest: test_forked_cpu_write-smem
[390.819578] Dynamic subtest test_forked_cpu_write-smem: SUCCESS (0.008s)
[390.831232] Starting dynamic subtest: test_forked_cpu_write-lmem0
[390.832255] Dynamic subtest test_forked_cpu_write-lmem0: SUCCESS (0.009s)
[390.833228] Subtest test_forked_cpu_write: SUCCESS (0.020s)
[390.978574] [117/133] (639s left) kms_flip (2x-nonexisting-fb)
[391.163308] Starting subtest: 2x-nonexisting-fb
[391.178490] Subtest 2x-nonexisting-fb: SKIP (0.014s)
[391.338457] [118/133] (639s left) kms_flip (flip-vs-panning-interruptible)
[391.527916] Starting subtest: flip-vs-panning-interruptible
[391.532771] Starting dynamic subtest: A-DP3
[399.361626] Dynamic subtest A-DP3: SUCCESS (7.828s)
[399.398655] Starting dynamic subtest: B-DP3
[407.160878] Dynamic subtest B-DP3: SUCCESS (7.794s)
[407.196063] Starting dynamic subtest: C-DP3
[414.934886] Dynamic subtest C-DP3: SUCCESS (7.768s)
[414.970303] Starting dynamic subtest: D-DP3
[422.709891] Dynamic subtest D-DP3: SUCCESS (7.770s)
[422.718277] Subtest flip-vs-panning-interruptible: SUCCESS (31.189s)
[423.105929] [119/133] (607s left) kms_ccs (ccs-on-another-bo-y-tiled-ccs)
[423.286909] Starting subtest: ccs-on-another-bo-y-tiled-ccs
[423.289154] Starting dynamic subtest: pipe-A-DP-3
[423.297367] Dynamic subtest pipe-A-DP-3: SKIP (0.000s)
[423.307383] Starting dynamic subtest: pipe-B-DP-3
[423.315795] Dynamic subtest pipe-B-DP-3: SKIP (0.000s)
[423.325582] Starting dynamic subtest: pipe-C-DP-3
[423.333851] Dynamic subtest pipe-C-DP-3: SKIP (0.000s)
[423.343846] Starting dynamic subtest: pipe-D-DP-3
[423.354464] Dynamic subtest pipe-D-DP-3: SKIP (0.000s)
[423.356454] Subtest ccs-on-another-bo-y-tiled-ccs: SKIP (0.006s)
[423.780551] [120/133] (606s left) i915_pm_rpm (debugfs-forcewake-user)
[425.995606] Starting subtest: debugfs-forcewake-user
[436.714302] Subtest debugfs-forcewake-user: SUCCESS (10.719s)
[437.139815] [121/133] (593s left) gem_eio (throttle)
[437.511522] Starting subtest: throttle
[438.154208] Subtest throttle: SUCCESS (0.643s)
[438.404437] [122/133] (592s left) gem_ctx_param (invalid-size-set)
[438.481778] Starting subtest: invalid-size-set
[438.484112] Subtest invalid-size-set: SUCCESS (0.001s)
[438.655462] [123/133] (592s left) perf_pmu (pmu-read)
[438.725215] Starting subtest: pmu-read
[438.729224] Subtest pmu-read: SUCCESS (0.004s)
[438.913875] [124/133] (591s left) gem_lmem_swapping (verify-ccs)
[441.726640] Starting subtest: verify-ccs
[441.727497] Starting dynamic subtest: lmem0
[486.035550] Dynamic subtest lmem0: SUCCESS (44.310s)
[486.036459] Subtest verify-ccs: SUCCESS (44.311s)
[488.028365] [FACT gem_lmem_swapping (verify-ccs)] deleted: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[488.029376] [FACT gem_lmem_swapping (verify-ccs)] deleted: kernel.kmod_is_loaded.i915: true
[488.031358] [125/133] (542s left) gen9_exec_parse (batch-invalid-length)
[489.680415] Subtest batch-invalid-length: SKIP (0.000s)
[489.728266] [FACT gen9_exec_parse (batch-invalid-length)] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[489.730570] [FACT gen9_exec_parse (batch-invalid-length)] new: kernel.kmod_is_loaded.i915: true
[489.734036] [126/133] (541s left) gem_softpin (overlap)
[489.861791] Starting subtest: overlap
[493.076216] Subtest overlap: SUCCESS (3.214s)
[493.261969] [127/133] (537s left) kms_big_fb (4-tiled-8bpp-rotate-180)
[493.464565] Starting subtest: 4-tiled-8bpp-rotate-180
[494.990091] Subtest 4-tiled-8bpp-rotate-180: SUCCESS (1.525s)
[495.190004] [128/133] (535s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-32bpp-ytilercccs-downscaling)
[495.377248] Starting subtest: flip-64bpp-ytile-to-32bpp-ytilercccs-downscaling
[495.379009] Subtest flip-64bpp-ytile-to-32bpp-ytilercccs-downscaling: SKIP (0.000s)
[495.543351] [129/133] (535s left) kms_psr2_sf (psr2-primary-plane-update-sf-dmg-area)
[495.736349] Subtest psr2-primary-plane-update-sf-dmg-area: SKIP (0.000s)
[495.798923] [130/133] (535s left) i915_pm_freq_api (freq-suspend)
[495.885451] Starting subtest: freq-suspend
[495.886424] Starting dynamic subtest: gt0
[514.433827] Dynamic subtest gt0: SUCCESS (3.952s)
[514.434590] Subtest freq-suspend: SUCCESS (3.954s)
[514.546963] [131/133] (516s left) prime_busy (after)
[514.639160] Starting subtest: after
[514.643957] Starting dynamic subtest: rcs0
[514.699433] Dynamic subtest rcs0: SUCCESS (0.055s)
[514.711603] Starting dynamic subtest: bcs0
[514.745008] Dynamic subtest bcs0: SUCCESS (0.045s)
[514.760271] Starting dynamic subtest: vcs0
[514.786836] Dynamic subtest vcs0: SUCCESS (0.040s)
[514.811372] Starting dynamic subtest: vcs1
[514.830925] Dynamic subtest vcs1: SUCCESS (0.042s)
[514.855468] Starting dynamic subtest: vecs0
[514.874204] Dynamic subtest vecs0: SUCCESS (0.041s)
[514.898667] Starting dynamic subtest: vecs1
[514.917418] Dynamic subtest vecs1: SUCCESS (0.041s)
[514.941331] Starting dynamic subtest: ccs0
[514.957689] Dynamic subtest ccs0: SUCCESS (0.038s)
[515.072102] Subtest after: SUCCESS (0.433s)
[515.273433] [132/133] (516s left) gem_exec_whisper (basic-contexts-forked)
[515.362120] Starting subtest: basic-contexts-forked
[537.700530] Subtest basic-contexts-forked: SUCCESS (22.408s)
[537.958438] [133/133] (493s left) syncobj_timeline (etime-single-wait-all-for-submit-unsubmitted)
[538.036794] Starting subtest: etime-single-wait-all-for-submit-unsubmitted
[538.144681] Subtest etime-single-wait-all-for-submit-unsubmitted: SUCCESS (0.107s)
[538.285504] 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.