[63.168637] Initializing watchdogs
[63.168702]   /dev/watchdog0
[63.187649] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:03:00.0: 8086:56a0 Intel Dg2 (Gen12) DG2 [Arc A770]
[63.198080] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[63.201721] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[63.204307] [001/133] (960s left) kms_color (ctm-0-25)
[63.385369] Starting subtest: ctm-0-25
[63.386276] Starting dynamic subtest: pipe-A-DP-3
[65.146873] Dynamic subtest pipe-A-DP-3: SUCCESS (1.760s)
[65.167296] Starting dynamic subtest: pipe-B-DP-3
[66.766240] Dynamic subtest pipe-B-DP-3: SUCCESS (1.619s)
[66.773592] Starting dynamic subtest: pipe-C-DP-3
[68.286490] Dynamic subtest pipe-C-DP-3: SUCCESS (1.520s)
[68.294812] Starting dynamic subtest: pipe-D-DP-3
[69.951413] Dynamic subtest pipe-D-DP-3: SUCCESS (1.664s)
[69.952295] Subtest ctm-0-25: SUCCESS (6.566s)
[70.246279] [002/133] (953s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-mmap-cpu)
[70.430847] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-mmap-cpu
[70.432480] Subtest fbc-2p-scndscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[70.611420] [003/133] (953s left) gem_exec_balancer (noheartbeat)
[70.996511] Starting subtest: noheartbeat
[70.998274] Subtest noheartbeat: SKIP (0.000s)
[71.116211] [004/133] (952s left) kms_cursor_legacy (cursorb-vs-flipb-atomic-transitions)
[71.299930] Starting subtest: cursorB-vs-flipB-atomic-transitions
[71.301712] Subtest cursorB-vs-flipB-atomic-transitions: SKIP (0.001s)
[71.440136] [005/133] (952s left) kms_busy (extended-pageflip-hang-oldfb)
[71.621674] Starting subtest: extended-pageflip-hang-oldfb
[71.623433] Starting dynamic subtest: pipe-A
[71.886241] Dynamic subtest pipe-A: SUCCESS (0.263s)
[71.906525] Starting dynamic subtest: pipe-D
[72.139893] Dynamic subtest pipe-D: SUCCESS (0.247s)
[72.140825] Subtest extended-pageflip-hang-oldfb: SUCCESS (0.518s)
[72.426473] [006/133] (951s left) kms_draw_crc (draw-method-mmap-wc)
[72.602916] Starting subtest: draw-method-mmap-wc
[72.604701] Subtest draw-method-mmap-wc: SKIP (0.000s)
[72.758595] [007/133] (951s left) kms_content_protection (uevent)
[73.000030] Starting subtest: uevent
[73.029411] Starting dynamic subtest: pipe-A-DP-3
[107.222119] Dynamic subtest pipe-A-DP-3: FAIL (34.146s)
[107.298203] Subtest uevent: FAIL (34.298s)
[107.581398] [008/133] (916s left) kms_cursor_crc (cursor-rapid-movement-32x32)
[107.864573] Starting subtest: cursor-rapid-movement-32x32
[107.915221] Subtest cursor-rapid-movement-32x32: SKIP (0.049s)
[108.348138] [009/133] (915s left) gem_render_copy (y-tiled-ccs-to-y-tiled-ccs)
[108.426396] Starting subtest: y-tiled-ccs-to-y-tiled-ccs
[108.428196] Subtest y-tiled-ccs-to-y-tiled-ccs: SKIP (0.000s)
[108.700547] [010/133] (915s left) gem_exec_fence (syncobj-import)
[109.286913] Starting subtest: syncobj-import
[109.318805] Subtest syncobj-import: SUCCESS (0.032s)
[109.747926] [FACT gem_exec_fence (syncobj-import)] new: kernel.kmod_is_loaded.vgem: true
[109.749552] [011/133] (914s left) gem_exec_flush (basic-wb-pro-default)
[109.831026] Subtest basic-wb-pro-default: SKIP (0.000s)
[109.911670] [012/133] (914s left) gem_exec_schedule (preempt-other)
[110.002399] Starting subtest: preempt-other
[110.003365] Starting dynamic subtest: rcs0
[110.552142] Dynamic subtest rcs0: SUCCESS (0.549s)
[110.560567] Starting dynamic subtest: bcs0
[111.081408] Dynamic subtest bcs0: SUCCESS (0.529s)
[111.089998] Starting dynamic subtest: vcs0
[111.605168] Dynamic subtest vcs0: SUCCESS (0.523s)
[111.613484] Starting dynamic subtest: vcs1
[112.154869] Dynamic subtest vcs1: SUCCESS (0.550s)
[112.163133] Starting dynamic subtest: vecs0
[112.675194] Dynamic subtest vecs0: SUCCESS (0.520s)
[112.683491] Starting dynamic subtest: vecs1
[113.430880] Dynamic subtest vecs1: SUCCESS (0.755s)
[113.439786] Starting dynamic subtest: ccs0
[113.975536] Dynamic subtest ccs0: SUCCESS (0.544s)
[113.976693] Subtest preempt-other: SUCCESS (3.973s)
[114.428382] [013/133] (910s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-blt)
[114.619494] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-blt
[114.621147] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[114.799551] [014/133] (909s left) gem_fence_thrash (bo-write-verify-threaded-y)
[114.844765] Starting subtest: bo-write-verify-threaded-y
[114.889273] Subtest bo-write-verify-threaded-y: SKIP (0.044s)
[115.013031] [015/133] (909s left) kms_addfb_basic (invalid-set-prop-any)
[115.095901] Starting subtest: invalid-set-prop-any
[115.096810] Subtest invalid-set-prop-any: SUCCESS (0.000s)
[115.373967] [016/133] (909s left) gem_pxp (reject-modify-context-protection-off-3)
[117.979187] Starting subtest: reject-modify-context-protection-off-3
[117.982500] Subtest reject-modify-context-protection-off-3: SKIP (0.000s)
[118.115341] [017/133] (906s left) gem_exec_schedule (fairslice-all)
[118.205822] Starting subtest: fairslice-all
[120.324879] Subtest fairslice-all: SUCCESS (2.119s)
[120.750014] [018/133] (904s left) kms_chamelium_edid (dp-mode-timings)
[121.034417] Subtest dp-mode-timings: SKIP (0.000s)
[121.189904] [019/133] (903s left) kms_ccs (crc-primary-rotation-180-4-tiled-mtl-mc-ccs)
[121.381180] Starting subtest: crc-primary-rotation-180-4-tiled-mtl-mc-ccs
[121.382094] Starting dynamic subtest: pipe-A-DP-3
[121.390325] Dynamic subtest pipe-A-DP-3: SKIP (0.001s)
[121.398913] Starting dynamic subtest: pipe-B-DP-3
[121.407188] Dynamic subtest pipe-B-DP-3: SKIP (0.001s)
[121.415485] Starting dynamic subtest: pipe-C-DP-3
[121.423788] Dynamic subtest pipe-C-DP-3: SKIP (0.001s)
[121.432029] Starting dynamic subtest: pipe-D-DP-3
[121.441121] Dynamic subtest pipe-D-DP-3: SKIP (0.001s)
[121.442994] Subtest crc-primary-rotation-180-4-tiled-mtl-mc-ccs: SKIP (0.006s)
[121.897550] [020/133] (903s left) gem_ctx_param (invalid-get-no-zeromap)
[121.975440] Starting subtest: invalid-get-no-zeromap
[121.977448] Subtest invalid-get-no-zeromap: SUCCESS (0.001s)
[122.175762] [021/133] (902s left) kms_frontbuffer_tracking (psr-1p-primscrn-indfb-msflip-blt)
[122.365354] Starting subtest: psr-1p-primscrn-indfb-msflip-blt
[122.367052] Subtest psr-1p-primscrn-indfb-msflip-blt: SKIP (0.000s)
[122.540392] [022/133] (902s left) i915_pm_rps (thresholds-idle)
[122.627525] Starting subtest: thresholds-idle
[122.629304] Subtest thresholds-idle: SKIP (0.000s)
[122.813145] [023/133] (902s left) gem_close (many-handles-one-vma)
[122.900463] Starting subtest: many-handles-one-vma
[122.929125] Subtest many-handles-one-vma: SUCCESS (0.029s)
[123.094483] [024/133] (902s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-shrfb-msflip-blt)
[123.292314] Starting subtest: fbcpsr-2p-primscrn-shrfb-msflip-blt
[123.294054] Subtest fbcpsr-2p-primscrn-shrfb-msflip-blt: SKIP (0.000s)
[123.509851] [025/133] (901s left) kms_chamelium_hpd (hdmi-hpd-with-enabled-mode)
[123.775008] Subtest hdmi-hpd-with-enabled-mode: SKIP (0.000s)
[123.920129] [026/133] (901s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-0-hflip)
[124.118414] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-0-hflip
[124.120211] Subtest y-tiled-max-hw-stride-32bpp-rotate-0-hflip: SKIP (0.000s)
[124.319427] [027/133] (901s left) gem_mmap_offset (clear-via-pagefault)
[124.398015] Starting subtest: clear-via-pagefault
[124.400297] Starting dynamic subtest: lmem0
[147.414240] Dynamic subtest lmem0: SUCCESS (23.011s)
[147.423489] Starting dynamic subtest: smem0
[172.731588] Dynamic subtest smem0: SUCCESS (25.317s)
[172.732440] Subtest clear-via-pagefault: SUCCESS (48.329s)
[173.002631] [028/133] (852s left) kms_pipe_b_c_ivb (disable-pipe-b-enable-pipe-c)
[173.108042] Subtest disable-pipe-B-enable-pipe-C: SKIP (0.000s)
[173.178905] [029/133] (852s left) kms_psr (pr-sprite-render)
[173.377689] Subtest pr-sprite-render: SKIP (0.000s)
[173.431013] [030/133] (852s left) gem_exec_reloc (basic-cpu-read-noreloc)
[173.577399] Subtest basic-cpu-read-noreloc: SKIP (0.000s)
[173.677008] [031/133] (852s left) kms_setmode (basic-clone-single-crtc)
[173.754933] Starting subtest: basic-clone-single-crtc
[173.757824] Subtest basic-clone-single-crtc: SKIP (0.000s)
[173.914785] [032/133] (851s left) gem_exec_alignment (pi-isolated)
[173.999555] Starting subtest: pi-isolated
[190.705519] Subtest pi-isolated: SUCCESS (16.704s)
[191.232501] [033/133] (834s left) gem_ctx_persistence (heartbeat-hang)
[191.365177] Starting subtest: heartbeat-hang
[191.366978] Subtest heartbeat-hang: SKIP (0.000s)
[191.516975] [034/133] (834s left) kms_display_modes (extended-mode-basic)
[191.713753] Starting subtest: extended-mode-basic
[191.716745] Subtest extended-mode-basic: SKIP (0.000s)
[191.790527] [035/133] (834s left) kms_plane (plane-position-hole)
[191.982160] Starting subtest: plane-position-hole
[192.407715] Starting dynamic subtest: pipe-A-plane-1
[192.845084] Dynamic subtest pipe-A-plane-1: SUCCESS (0.437s)
[192.857010] Starting dynamic subtest: pipe-A-plane-2
[193.303490] Dynamic subtest pipe-A-plane-2: SUCCESS (0.459s)
[193.314061] Starting dynamic subtest: pipe-A-plane-3
[193.761693] Dynamic subtest pipe-A-plane-3: SUCCESS (0.458s)
[193.776669] Starting dynamic subtest: pipe-A-plane-4
[194.228627] Dynamic subtest pipe-A-plane-4: SUCCESS (0.466s)
[194.240109] Starting dynamic subtest: pipe-A-plane-5
[194.253937] Dynamic subtest pipe-A-plane-5: SUCCESS (0.024s)
[194.613592] Starting dynamic subtest: pipe-B-plane-1
[195.029550] Dynamic subtest pipe-B-plane-1: SUCCESS (0.425s)
[195.039326] Starting dynamic subtest: pipe-B-plane-2
[195.486398] Dynamic subtest pipe-B-plane-2: SUCCESS (0.456s)
[195.496081] Starting dynamic subtest: pipe-B-plane-3
[195.925510] Dynamic subtest pipe-B-plane-3: SUCCESS (0.439s)
[195.934961] Starting dynamic subtest: pipe-B-plane-4
[196.361559] Dynamic subtest pipe-B-plane-4: SUCCESS (0.436s)
[196.371078] Starting dynamic subtest: pipe-B-plane-5
[196.382385] Dynamic subtest pipe-B-plane-5: SUCCESS (0.019s)
[196.383242] Subtest plane-position-hole: SUCCESS (4.401s)
[196.671609] [036/133] (829s left) kms_pm_backlight (bad-brightness)
[196.859642] Subtest bad-brightness: SKIP (0.000s)
[196.913821] [037/133] (829s left) syncobj_timeline (multi-wait-available-unsubmitted-signaled)
[196.996618] Starting subtest: multi-wait-available-unsubmitted-signaled
[196.997497] Subtest multi-wait-available-unsubmitted-signaled: SUCCESS (0.001s)
[197.137800] [038/133] (829s left) kms_mmap_write_crc (main)
[197.327699] Starting subtest: main
[197.329487] Starting dynamic subtest: pipe-A-DP-3
[201.074611] Dynamic subtest pipe-A-DP-3: SUCCESS (3.744s)
[201.075882] Subtest main: SUCCESS (3.746s)
[201.408107] [039/133] (824s left) gem_spin_batch (resubmit-new-all)
[201.499158] Starting subtest: resubmit-new-all
[201.500014] Starting dynamic subtest: rcs0
[201.535299] Dynamic subtest rcs0: SUCCESS (0.037s)
[201.544568] Starting dynamic subtest: bcs0
[201.545479] Dynamic subtest bcs0: SUCCESS (0.009s)
[201.554747] Starting dynamic subtest: vcs0
[201.555549] Dynamic subtest vcs0: SUCCESS (0.008s)
[201.564763] Starting dynamic subtest: vcs1
[201.565513] Dynamic subtest vcs1: SUCCESS (0.010s)
[201.575193] Starting dynamic subtest: vecs0
[201.576114] Dynamic subtest vecs0: SUCCESS (0.009s)
[201.585385] Starting dynamic subtest: vecs1
[201.586307] Dynamic subtest vecs1: SUCCESS (0.008s)
[201.595645] Starting dynamic subtest: ccs0
[201.596688] Dynamic subtest ccs0: SUCCESS (0.009s)
[201.597750] Subtest resubmit-new-all: SUCCESS (0.093s)
[201.988759] [040/133] (824s left) kms_flip (flip-vs-rmfb-interruptible)
[202.176191] Starting subtest: flip-vs-rmfb-interruptible
[202.180747] Starting dynamic subtest: A-DP3
[209.996131] Dynamic subtest A-DP3: SUCCESS (7.814s)
[210.034174] Starting dynamic subtest: B-DP3
[217.760819] Dynamic subtest B-DP3: SUCCESS (7.761s)
[217.791457] Starting dynamic subtest: C-DP3
[225.507358] Dynamic subtest C-DP3: SUCCESS (7.743s)
[225.545175] Starting dynamic subtest: D-DP3
[233.271021] Dynamic subtest D-DP3: SUCCESS (7.759s)
[233.276904] Subtest flip-vs-rmfb-interruptible: SUCCESS (31.099s)
[233.687281] [041/133] (792s left) kms_rotation_crc (sprite-rotation-180)
[233.871448] Starting subtest: sprite-rotation-180
[244.139179] Subtest sprite-rotation-180: SUCCESS (10.267s)
[244.560983] [042/133] (782s left) gem_exec_alignment (single)
[244.646182] Starting subtest: single
[244.652349] Subtest single: SUCCESS (0.006s)
[244.828387] [043/133] (781s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-180-hflip)
[245.025172] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-180-hflip
[246.281561] Subtest x-tiled-max-hw-stride-32bpp-rotate-180-hflip: SUCCESS (1.255s)
[246.527816] [044/133] (780s left) kms_frontbuffer_tracking (psr-1p-primscrn-shrfb-plflip-blt)
[246.719974] Starting subtest: psr-1p-primscrn-shrfb-plflip-blt
[246.721711] Subtest psr-1p-primscrn-shrfb-plflip-blt: SKIP (0.000s)
[246.883995] [045/133] (779s left) syncobj_wait (invalid-signal-zero-handles)
[246.964237] Starting subtest: invalid-signal-zero-handles
[246.965143] Subtest invalid-signal-zero-handles: SUCCESS (0.000s)
[247.159464] [046/133] (779s left) kms_async_flips (alternate-sync-async-flip)
[247.348272] Starting subtest: alternate-sync-async-flip
[247.581391] Starting dynamic subtest: pipe-A-DP-3
[249.878894] Dynamic subtest pipe-A-DP-3: SUCCESS (2.296s)
[250.124212] Starting dynamic subtest: pipe-B-DP-3
[252.249606] Dynamic subtest pipe-B-DP-3: SUCCESS (2.136s)
[252.464337] Starting dynamic subtest: pipe-C-DP-3
[254.589721] Dynamic subtest pipe-C-DP-3: SUCCESS (2.135s)
[254.801197] Starting dynamic subtest: pipe-D-DP-3
[256.927097] Dynamic subtest pipe-D-DP-3: SUCCESS (2.135s)
[256.931372] Subtest alternate-sync-async-flip: SUCCESS (9.581s)
[257.450021] [047/133] (769s left) kms_frontbuffer_tracking (fbcpsr-1p-rte)
[257.645241] Starting subtest: fbcpsr-1p-rte
[257.646941] Subtest fbcpsr-1p-rte: SKIP (0.000s)
[257.835980] [048/133] (769s left) perf (gen12-group-exclusive-stream-ctx-handle)
[258.255092] Starting subtest: gen12-group-exclusive-stream-ctx-handle
[258.281904] Subtest gen12-group-exclusive-stream-ctx-handle: SUCCESS (0.026s)
[258.332116] [049/133] (768s left) gem_render_copy_redux (flink-interruptible)
[258.453843] Starting subtest: flink-interruptible
[261.562602] Subtest flink-interruptible: SUCCESS (3.109s)
[261.791062] [050/133] (765s left) gem_userptr_blits (probe)
[261.889100] Starting subtest: probe
[262.016896] Subtest probe: SUCCESS (0.118s)
[262.196634] [051/133] (765s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-shrfb-msflip-blt)
[262.387231] Starting subtest: fbc-2p-scndscrn-shrfb-msflip-blt
[262.388994] Subtest fbc-2p-scndscrn-shrfb-msflip-blt: SKIP (0.000s)
[262.563013] [052/133] (764s left) gem_lmem_swapping (heavy-verify-multi-ccs)
[265.339770] Starting subtest: heavy-verify-multi-ccs
[265.340592] Starting dynamic subtest: lmem0
[277.116797] Dynamic subtest lmem0: SUCCESS (11.778s)
[277.117658] Subtest heavy-verify-multi-ccs: SUCCESS (11.779s)
[278.656713] [FACT gem_lmem_swapping (heavy-verify-multi-ccs)] deleted: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[278.657795] [FACT gem_lmem_swapping (heavy-verify-multi-ccs)] deleted: kernel.kmod_is_loaded.i915: true
[278.660139] [053/133] (748s left) core_getclient (basic)
[280.249143] Starting subtest: basic
[280.249928] Subtest basic: SUCCESS (0.000s)
[280.317099] [FACT core_getclient (basic)] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[280.319772] [FACT core_getclient (basic)] new: kernel.kmod_is_loaded.i915: true
[280.322761] [054/133] (747s left) kms_cursor_crc (cursor-onscreen-128x128)
[280.699186] Starting subtest: cursor-onscreen-128x128
[280.714449] Starting dynamic subtest: pipe-A-DP-3
[283.399079] Dynamic subtest pipe-A-DP-3: SUCCESS (2.682s)
[283.448058] Starting dynamic subtest: pipe-D-DP-3
[286.181997] Dynamic subtest pipe-D-DP-3: SUCCESS (2.742s)
[286.182998] Subtest cursor-onscreen-128x128: SUCCESS (5.483s)
[286.662130] [055/133] (740s left) kms_plane_lowres (tiling-y)
[286.851754] Starting subtest: tiling-y
[286.853424] Subtest tiling-y: SKIP (0.000s)
[286.998499] [056/133] (740s left) api_intel_allocator (gem-pool)
[287.074241] Starting subtest: gem-pool
[287.108152] Subtest gem-pool: SUCCESS (0.034s)
[287.263489] [057/133] (740s left) i915_drm_fdinfo (isolation)
[287.338434] Starting subtest: isolation
[287.339341] Starting dynamic subtest: rcs0
[287.341091] Dynamic subtest rcs0: SKIP (0.000s)
[287.350627] Starting dynamic subtest: bcs0
[287.352826] Dynamic subtest bcs0: SKIP (0.000s)
[287.362103] Starting dynamic subtest: vcs0
[287.364400] Dynamic subtest vcs0: SKIP (0.000s)
[287.373605] Starting dynamic subtest: vcs1
[287.375811] Dynamic subtest vcs1: SKIP (0.000s)
[287.384730] Starting dynamic subtest: vecs0
[287.386980] Dynamic subtest vecs0: SKIP (0.001s)
[287.396249] Starting dynamic subtest: vecs1
[287.398581] Dynamic subtest vecs1: SKIP (0.011s)
[287.407526] Starting dynamic subtest: ccs0
[287.409648] Dynamic subtest ccs0: SKIP (0.000s)
[287.411888] Subtest isolation: SKIP (0.021s)
[287.465584] [058/133] (740s left) gem_exec_parallel (basic)
[287.554382] Starting subtest: basic
[287.555299] Starting dynamic subtest: rcs0
[289.084376] Dynamic subtest rcs0: SUCCESS (1.529s)
[289.096189] Starting dynamic subtest: bcs0
[290.562921] Dynamic subtest bcs0: SUCCESS (1.477s)
[290.576307] Starting dynamic subtest: vcs0
[292.066272] Dynamic subtest vcs0: SUCCESS (1.502s)
[292.077010] Starting dynamic subtest: vcs1
[293.560365] Dynamic subtest vcs1: SUCCESS (1.493s)
[293.572069] Starting dynamic subtest: vecs0
[295.049672] Dynamic subtest vecs0: SUCCESS (1.488s)
[295.061535] Starting dynamic subtest: vecs1
[296.501517] Dynamic subtest vecs1: SUCCESS (1.451s)
[296.512542] Starting dynamic subtest: ccs0
[297.973152] Dynamic subtest ccs0: SUCCESS (1.470s)
[297.974160] Subtest basic: SUCCESS (10.420s)
[298.298103] [059/133] (729s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-mmap-cpu)
[298.491890] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-mmap-cpu
[298.493567] Subtest fbc-2p-scndscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[298.693830] [060/133] (729s left) kms_getfb (getfb-handle-valid)
[298.882352] Starting subtest: getfb-handle-valid
[298.883236] Subtest getfb-handle-valid: SUCCESS (0.000s)
[299.081785] [061/133] (728s left) perf (invalid-remove-userspace-config)
[299.485413] Starting subtest: invalid-remove-userspace-config
[299.494360] Subtest invalid-remove-userspace-config: SUCCESS (0.010s)
[299.547894] [062/133] (728s left) kms_psr2_sf (pr-primary-plane-update-sf-dmg-area)
[299.741428] Subtest pr-primary-plane-update-sf-dmg-area: SKIP (0.000s)
[299.794385] [063/133] (728s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-mmap-cpu)
[299.985090] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-mmap-cpu
[299.986880] Subtest fbc-2p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[300.162624] [064/133] (727s left) kms_ccs (bad-rotation-90-4-tiled-dg2-rc-ccs-cc)
[300.344298] Starting subtest: bad-rotation-90-4-tiled-dg2-rc-ccs-cc
[300.345173] Starting dynamic subtest: pipe-A-DP-3
[300.353325] Dynamic subtest pipe-A-DP-3: SKIP (0.000s)
[300.362518] Starting dynamic subtest: pipe-B-DP-3
[300.370844] Dynamic subtest pipe-B-DP-3: SKIP (0.000s)
[300.379900] Starting dynamic subtest: pipe-C-DP-3
[300.388117] Dynamic subtest pipe-C-DP-3: SKIP (0.000s)
[300.397347] Starting dynamic subtest: pipe-D-DP-3
[300.408521] Dynamic subtest pipe-D-DP-3: SKIP (0.000s)
[300.410468] Subtest bad-rotation-90-4-tiled-dg2-rc-ccs-cc: SKIP (0.007s)
[300.811444] [065/133] (727s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-blt)
[301.005223] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-blt
[301.006964] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-blt: SKIP (0.000s)
[301.192915] [066/133] (727s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-indfb-msflip-blt)
[301.386157] Starting subtest: fbcpsr-2p-scndscrn-indfb-msflip-blt
[301.387906] Subtest fbcpsr-2p-scndscrn-indfb-msflip-blt: SKIP (0.000s)
[301.576135] [067/133] (726s left) kms_pm_rpm (cursor-dpms)
[303.992880] Starting subtest: cursor-dpms
[303.994930] Subtest cursor-dpms: SKIP (0.000s)
[304.463301] [068/133] (723s left) gem_ccs (block-multicopy-inplace)
[304.556401] Starting subtest: block-multicopy-inplace
[304.557300] Starting dynamic subtest: linear-compressed-compfmt0-smem-lmem0-multicopy
[304.599899] Dynamic subtest linear-compressed-compfmt0-smem-lmem0-multicopy: SUCCESS (0.044s)
[304.610768] Starting dynamic subtest: linear-compressed-compfmt0-lmem0-lmem0-multicopy
[304.699409] Dynamic subtest linear-compressed-compfmt0-lmem0-lmem0-multicopy: SUCCESS (0.098s)
[304.710262] Starting dynamic subtest: xmajor-compressed-compfmt0-smem-lmem0-multicopy
[304.714897] Dynamic subtest xmajor-compressed-compfmt0-smem-lmem0-multicopy: SUCCESS (0.014s)
[304.725855] Starting dynamic subtest: xmajor-compressed-compfmt0-lmem0-lmem0-multicopy
[304.817517] Dynamic subtest xmajor-compressed-compfmt0-lmem0-lmem0-multicopy: SUCCESS (0.102s)
[304.828580] Starting dynamic subtest: tile4-compressed-compfmt0-smem-lmem0-multicopy
[304.833092] Dynamic subtest tile4-compressed-compfmt0-smem-lmem0-multicopy: SUCCESS (0.014s)
[304.843979] Starting dynamic subtest: tile4-compressed-compfmt0-lmem0-lmem0-multicopy
[304.935200] Dynamic subtest tile4-compressed-compfmt0-lmem0-lmem0-multicopy: SUCCESS (0.101s)
[304.946235] Starting dynamic subtest: tile64-compressed-compfmt0-smem-lmem0-multicopy
[304.951487] Dynamic subtest tile64-compressed-compfmt0-smem-lmem0-multicopy: SUCCESS (0.015s)
[304.962402] Starting dynamic subtest: tile64-compressed-compfmt0-lmem0-lmem0-multicopy
[305.038914] Dynamic subtest tile64-compressed-compfmt0-lmem0-lmem0-multicopy: SUCCESS (0.086s)
[305.039780] Subtest block-multicopy-inplace: SUCCESS (0.484s)
[305.252790] [069/133] (723s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-0)
[305.448126] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-0
[305.449844] Subtest yf-tiled-max-hw-stride-64bpp-rotate-0: SKIP (0.000s)
[305.649664] [070/133] (722s left) kms_cursor_edge_walk (64x64-top-bottom)
[305.836899] Starting subtest: 64x64-top-bottom
[305.839134] Starting dynamic subtest: pipe-A-DP-3
[309.292607] Dynamic subtest pipe-A-DP-3: SUCCESS (3.453s)
[309.305964] Starting dynamic subtest: pipe-D-DP-3
[312.619505] Dynamic subtest pipe-D-DP-3: SUCCESS (3.325s)
[312.620458] Subtest 64x64-top-bottom: SUCCESS (6.783s)
[312.940078] [071/133] (715s left) syncobj_timeline (invalid-single-wait-all-unsubmitted)
[313.027541] Starting subtest: invalid-single-wait-all-unsubmitted
[313.028463] Subtest invalid-single-wait-all-unsubmitted: SUCCESS (0.000s)
[313.224830] [072/133] (715s left) gem_exec_capture (pi)
[313.315393] Starting subtest: pi
[313.316278] Starting dynamic subtest: rcs0
[319.097452] Dynamic subtest rcs0: SUCCESS (5.782s)
[319.107059] Starting dynamic subtest: bcs0
[324.901040] Dynamic subtest bcs0: SUCCESS (5.801s)
[324.910822] Starting dynamic subtest: vcs0
[330.640975] Dynamic subtest vcs0: SUCCESS (5.739s)
[330.651692] Starting dynamic subtest: vcs1
[336.514724] Dynamic subtest vcs1: SUCCESS (5.874s)
[336.524390] Starting dynamic subtest: vecs0
[342.491259] Dynamic subtest vecs0: SUCCESS (5.975s)
[342.501573] Starting dynamic subtest: vecs1
[348.485898] Dynamic subtest vecs1: SUCCESS (5.994s)
[348.495458] Starting dynamic subtest: ccs0
[351.048618] Dynamic subtest ccs0: FAIL (2.531s)
[351.049459] Subtest pi: FAIL (37.707s)
[354.260068] [073/133] (674s left) kms_plane (pixel-format-y-tiled-gen12-rc-ccs-cc-modifier-source-clamping)
[354.485533] Starting subtest: pixel-format-y-tiled-gen12-rc-ccs-cc-modifier-source-clamping
[354.487235] Subtest pixel-format-y-tiled-gen12-rc-ccs-cc-modifier-source-clamping: SKIP (0.000s)
[354.609017] [074/133] (674s left) kms_hdr (static-swap)
[354.795610] Starting subtest: static-swap
[358.436191] Starting dynamic subtest: pipe-A-DP-3
[359.591459] Dynamic subtest pipe-A-DP-3: SUCCESS (1.155s)
[359.597350] Subtest static-swap: SUCCESS (4.798s)
[359.984626] [075/133] (668s left) syncobj_wait (wait-for-submit-delayed-submit)
[360.076899] Starting subtest: wait-for-submit-delayed-submit
[360.179057] Subtest wait-for-submit-delayed-submit: SUCCESS (0.103s)
[360.323546] [076/133] (668s left) kms_vrr (flip-dpms)
[360.510356] Starting subtest: flip-dpms
[360.512996] Subtest flip-dpms: SKIP (0.000s)
[360.640821] [077/133] (668s left) kms_big_fb (linear-addfb)
[360.841982] Starting subtest: linear-addfb
[360.842785] Subtest linear-addfb: SUCCESS (0.000s)
[361.049259] [078/133] (668s left) kms_addfb_basic (addfb25-bad-modifier)
[361.244382] Starting subtest: addfb25-bad-modifier
[361.245274] Subtest addfb25-bad-modifier: SUCCESS (0.000s)
[361.448041] [079/133] (667s left) kms_psr (psr-sprite-plane-onoff)
[361.640580] Subtest psr-sprite-plane-onoff: SKIP (0.000s)
[361.695297] [080/133] (667s left) kms_psr (fbc-psr-sprite-plane-move)
[361.883635] Subtest fbc-psr-sprite-plane-move: SKIP (0.000s)
[361.945472] [081/133] (667s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-blt)
[362.138510] Starting subtest: fbcpsr-rgb101010-draw-blt
[362.140221] Subtest fbcpsr-rgb101010-draw-blt: SKIP (0.000s)
[362.307653] [082/133] (667s left) kms_prop_blob (invalid-get-prop)
[362.382632] Starting subtest: invalid-get-prop
[362.383520] Subtest invalid-get-prop: SUCCESS (0.000s)
[362.566660] [083/133] (666s left) sysfs_preempt_timeout (idempotent)
[362.651645] Starting subtest: idempotent
[362.653963] Starting dynamic subtest: vecs0
[362.654831] Dynamic subtest vecs0: SUCCESS (0.001s)
[362.664334] Starting dynamic subtest: ccs0
[362.665244] Dynamic subtest ccs0: SUCCESS (0.001s)
[362.675232] Starting dynamic subtest: vcs0
[362.676119] Dynamic subtest vcs0: SUCCESS (0.001s)
[362.685457] Starting dynamic subtest: bcs0
[362.686524] Dynamic subtest bcs0: SUCCESS (0.001s)
[362.696197] Starting dynamic subtest: vecs1
[362.697473] Dynamic subtest vecs1: SUCCESS (0.001s)
[362.707171] Starting dynamic subtest: rcs0
[362.708424] Dynamic subtest rcs0: SUCCESS (0.001s)
[362.717998] Starting dynamic subtest: vcs1
[362.719082] Dynamic subtest vcs1: SUCCESS (0.001s)
[362.720140] Subtest idempotent: SUCCESS (0.013s)
[362.783873] [084/133] (666s left) kms_psr (fbc-pr-primary-page-flip)
[362.980487] Subtest fbc-pr-primary-page-flip: SKIP (0.000s)
[363.044817] [085/133] (666s left) gem_exec_reloc (basic-gtt-active)
[363.130322] Subtest basic-gtt-active: SKIP (0.000s)
[363.219414] [086/133] (666s left) kms_chamelium_color (ctm-0-75)
[363.405392] Subtest ctm-0-75: SKIP (0.000s)
[363.464130] [087/133] (666s left) kms_flip_scaled_crc (flip-64bpp-linear-to-16bpp-linear-upscaling)
[363.654325] Starting subtest: flip-64bpp-linear-to-16bpp-linear-upscaling
[363.655251] Starting dynamic subtest: pipe-A-valid-mode
[365.504769] Dynamic subtest pipe-A-valid-mode: SUCCESS (1.846s)
[365.506207] Subtest flip-64bpp-linear-to-16bpp-linear-upscaling: SUCCESS (1.850s)
[365.805471] [088/133] (663s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-move)
[365.996209] Starting subtest: fbc-1p-primscrn-spr-indfb-move
[369.421763] Subtest fbc-1p-primscrn-spr-indfb-move: SUCCESS (3.426s)
[369.709834] [089/133] (660s left) kms_frontbuffer_tracking (psr-indfb-scaledprimary)
[369.900241] Starting subtest: psr-indfb-scaledprimary
[369.901969] Subtest psr-indfb-scaledprimary: SKIP (0.000s)
[370.086626] [090/133] (659s left) kms_big_fb (linear-max-hw-stride-64bpp-rotate-180-hflip)
[370.280294] Starting subtest: linear-max-hw-stride-64bpp-rotate-180-hflip
[370.282036] Subtest linear-max-hw-stride-64bpp-rotate-180-hflip: SKIP (0.000s)
[370.487094] [091/133] (659s left) syncobj_eventfd (timeline-wait)
[370.566425] Starting subtest: timeline-wait
[370.576790] Subtest timeline-wait: SUCCESS (0.010s)
[370.720523] [092/133] (659s left) gem_sync (basic-store-each)
[370.809968] Starting subtest: basic-store-each
[374.870707] Subtest basic-store-each: SUCCESS (4.059s)
[375.086109] [093/133] (655s left) core_getversion (all-cards)
[375.150243] Starting subtest: all-cards
[375.185351] Subtest all-cards: SUCCESS (0.036s)
[375.232814] [094/133] (655s left) gem_ctx_exec (basic-invalid-context)
[375.312413] Starting subtest: basic-invalid-context
[375.317043] Subtest basic-invalid-context: SUCCESS (0.005s)
[375.517674] [095/133] (654s left) kms_frontbuffer_tracking (fbc-1p-primscrn-shrfb-msflip-blt)
[375.706463] Starting subtest: fbc-1p-primscrn-shrfb-msflip-blt
[378.572488] Subtest fbc-1p-primscrn-shrfb-msflip-blt: SUCCESS (2.866s)
[378.821900] [096/133] (651s left) kms_prop_blob (blob-multiple)
[378.902387] Starting subtest: blob-multiple
[378.934383] Subtest blob-multiple: SUCCESS (0.031s)
[379.103975] [097/133] (651s left) kms_invalid_mode (zero-clock)
[379.294292] Starting subtest: zero-clock
[379.295232] Starting dynamic subtest: pipe-A-DP-3
[379.381978] Dynamic subtest pipe-A-DP-3: SUCCESS (0.085s)
[379.395551] Starting dynamic subtest: pipe-B-DP-3
[379.396777] Dynamic subtest pipe-B-DP-3: SUCCESS (0.001s)
[379.410052] Starting dynamic subtest: pipe-C-DP-3
[379.411210] Dynamic subtest pipe-C-DP-3: SUCCESS (0.001s)
[379.423598] Starting dynamic subtest: pipe-D-DP-3
[379.424561] Dynamic subtest pipe-D-DP-3: SUCCESS (0.001s)
[379.425489] Subtest zero-clock: SUCCESS (0.097s)
[379.655406] [098/133] (650s left) kms_flip_scaled_crc (flip-32bpp-4tile-to-64bpp-4tile-upscaling)
[379.850440] Starting subtest: flip-32bpp-4tile-to-64bpp-4tile-upscaling
[379.851306] Starting dynamic subtest: pipe-A-valid-mode
[382.376968] Dynamic subtest pipe-A-valid-mode: SUCCESS (2.524s)
[382.378593] Subtest flip-32bpp-4tile-to-64bpp-4tile-upscaling: SUCCESS (2.527s)
[382.698446] [099/133] (647s left) kms_ccs (random-ccs-data-4-tiled-dg2-rc-ccs)
[382.885769] Starting subtest: random-ccs-data-4-tiled-dg2-rc-ccs
[382.888350] Starting dynamic subtest: pipe-A-DP-3
[382.897652] Dynamic subtest pipe-A-DP-3: SKIP (0.000s)
[382.907609] Starting dynamic subtest: pipe-B-DP-3
[382.917237] Dynamic subtest pipe-B-DP-3: SKIP (0.000s)
[382.926992] Starting dynamic subtest: pipe-C-DP-3
[382.936100] Dynamic subtest pipe-C-DP-3: SKIP (0.000s)
[382.945718] Starting dynamic subtest: pipe-D-DP-3
[382.958072] Dynamic subtest pipe-D-DP-3: SKIP (0.000s)
[382.960549] Subtest random-ccs-data-4-tiled-dg2-rc-ccs: SKIP (0.007s)
[383.378916] [100/133] (647s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-mmap-gtt)
[383.569192] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-mmap-gtt
[383.570941] Subtest psr-2p-scndscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[383.764902] [101/133] (647s left) gem_tiled_wc
[383.907411] [102/133] (646s left) kms_universal_plane (universal-plane-sanity)
[384.102286] Starting subtest: universal-plane-sanity
[384.103209] Starting dynamic subtest: pipe-A-DP-3
[384.737795] Dynamic subtest pipe-A-DP-3: SUCCESS (0.632s)
[384.762931] Starting dynamic subtest: pipe-B-DP-3
[385.252525] Dynamic subtest pipe-B-DP-3: SUCCESS (0.510s)
[385.268983] Starting dynamic subtest: pipe-C-DP-3
[385.740537] Dynamic subtest pipe-C-DP-3: SUCCESS (0.486s)
[385.756279] Starting dynamic subtest: pipe-D-DP-3
[386.230918] Dynamic subtest pipe-D-DP-3: SUCCESS (0.487s)
[386.231916] Subtest universal-plane-sanity: SUCCESS (2.129s)
[386.516050] [103/133] (644s left) kms_plane_alpha_blend (alpha-opaque-fb)
[386.699766] Starting subtest: alpha-opaque-fb
[386.950370] Starting dynamic subtest: pipe-A-DP-3
[387.474162] Dynamic subtest pipe-A-DP-3: SUCCESS (0.522s)
[387.483998] Starting dynamic subtest: pipe-D-DP-3
[388.067170] Dynamic subtest pipe-D-DP-3: SUCCESS (0.592s)
[388.068032] Subtest alpha-opaque-fb: SUCCESS (1.367s)
[388.386812] [104/133] (642s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-mmap-gtt)
[388.577161] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-mmap-gtt
[388.578936] Subtest fbc-1p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[388.734458] [105/133] (642s left) kms_psr (psr2-primary-mmap-gtt)
[388.924043] Subtest psr2-primary-mmap-gtt: SKIP (0.000s)
[388.979355] [106/133] (642s left) gem_exec_schedule (semaphore-codependency)
[389.071963] Starting subtest: semaphore-codependency
[389.113562] Subtest semaphore-codependency: SUCCESS (0.042s)
[389.536175] [107/133] (641s left) gem_pread (bench)
[389.613265] Subtest bench: SKIP (0.000s)
[389.679362] [108/133] (641s left) drm_read (fault-buffer)
[389.936805] Starting subtest: fault-buffer
[389.937750] Subtest fault-buffer: SUCCESS (0.001s)
[390.217748] [109/133] (641s left) kms_frontbuffer_tracking (psr-2p-primscrn-shrfb-pgflip-blt)
[390.405742] Starting subtest: psr-2p-primscrn-shrfb-pgflip-blt
[390.407446] Subtest psr-2p-primscrn-shrfb-pgflip-blt: SKIP (0.000s)
[390.579873] [110/133] (640s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-render)
[390.767894] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-render
[390.769671] Subtest fbc-2p-scndscrn-pri-shrfb-draw-render: SKIP (0.000s)
[390.947512] [111/133] (640s left) gem_softpin (evict-snoop)
[391.036803] Starting subtest: evict-snoop
[391.038575] Subtest evict-snoop: SKIP (0.000s)
[391.183581] [112/133] (640s left) kms_getfb (getfb-handle-not-fb)
[391.373394] Starting subtest: getfb-handle-not-fb
[391.374286] Subtest getfb-handle-not-fb: SUCCESS (0.000s)
[391.559247] [113/133] (640s left) syncobj_timeline (wait-all-delayed-signal)
[391.631811] Starting subtest: wait-all-delayed-signal
[391.733436] Subtest wait-all-delayed-signal: SUCCESS (0.101s)
[391.917427] [114/133] (639s left) kms_atomic (plane-invalid-params-fence)
[392.104628] Starting subtest: plane-invalid-params-fence
[392.107177] Starting dynamic subtest: pipe-A-DP-3
[392.630698] Dynamic subtest pipe-A-DP-3: SUCCESS (0.524s)
[392.631758] Subtest plane-invalid-params-fence: SUCCESS (0.526s)
[392.954489] [115/133] (638s left) gem_mmap_gtt (coherency)
[393.036279] Subtest coherency: SKIP (0.000s)
[393.118193] [116/133] (638s left) prime_mmap (test_forked_cpu_write)
[393.193841] Starting subtest: test_forked_cpu_write
[393.194711] Starting dynamic subtest: test_forked_cpu_write-smem
[393.202971] Dynamic subtest test_forked_cpu_write-smem: SUCCESS (0.009s)
[393.214726] Starting dynamic subtest: test_forked_cpu_write-lmem0
[393.215623] Dynamic subtest test_forked_cpu_write-lmem0: SUCCESS (0.009s)
[393.216751] Subtest test_forked_cpu_write: SUCCESS (0.020s)
[393.439517] [117/133] (638s left) kms_flip (2x-nonexisting-fb)
[393.627908] Starting subtest: 2x-nonexisting-fb
[393.641908] Subtest 2x-nonexisting-fb: SKIP (0.014s)
[393.809646] [118/133] (638s left) kms_flip (flip-vs-panning-interruptible)
[393.999187] Starting subtest: flip-vs-panning-interruptible
[394.004123] Starting dynamic subtest: A-DP3
[401.822703] Dynamic subtest A-DP3: SUCCESS (7.818s)
[401.861601] Starting dynamic subtest: B-DP3
[409.615950] Dynamic subtest B-DP3: SUCCESS (7.787s)
[409.649374] Starting dynamic subtest: C-DP3
[417.390947] Dynamic subtest C-DP3: SUCCESS (7.769s)
[417.427471] Starting dynamic subtest: D-DP3
[425.165111] Dynamic subtest D-DP3: SUCCESS (7.769s)
[425.173449] Subtest flip-vs-panning-interruptible: SUCCESS (31.173s)
[425.544785] [119/133] (606s left) kms_ccs (ccs-on-another-bo-y-tiled-ccs)
[425.727534] Starting subtest: ccs-on-another-bo-y-tiled-ccs
[425.729860] Starting dynamic subtest: pipe-A-DP-3
[425.738264] Dynamic subtest pipe-A-DP-3: SKIP (0.000s)
[425.748225] Starting dynamic subtest: pipe-B-DP-3
[425.756877] Dynamic subtest pipe-B-DP-3: SKIP (0.000s)
[425.766642] Starting dynamic subtest: pipe-C-DP-3
[425.775056] Dynamic subtest pipe-C-DP-3: SKIP (0.000s)
[425.784957] Starting dynamic subtest: pipe-D-DP-3
[425.795043] Dynamic subtest pipe-D-DP-3: SKIP (0.000s)
[425.797368] Subtest ccs-on-another-bo-y-tiled-ccs: SKIP (0.006s)
[426.219322] [120/133] (606s left) i915_pm_rpm (debugfs-forcewake-user)
[428.033457] Starting subtest: debugfs-forcewake-user
[438.754820] Subtest debugfs-forcewake-user: SUCCESS (10.721s)
[439.126705] [121/133] (593s left) gem_eio (throttle)
[439.484352] Starting subtest: throttle
[440.121360] Subtest throttle: SUCCESS (0.637s)
[440.409177] [122/133] (592s left) gem_ctx_param (invalid-size-set)
[440.485804] Starting subtest: invalid-size-set
[440.488225] Subtest invalid-size-set: SUCCESS (0.001s)
[440.669800] [123/133] (591s left) perf_pmu (pmu-read)
[440.739069] Starting subtest: pmu-read
[440.742938] Subtest pmu-read: SUCCESS (0.004s)
[440.940949] [124/133] (591s left) gem_lmem_swapping (verify-ccs)
[443.651587] Starting subtest: verify-ccs
[443.652440] Starting dynamic subtest: lmem0
[488.339362] Dynamic subtest lmem0: SUCCESS (44.686s)
[488.340365] Subtest verify-ccs: SUCCESS (44.688s)
[490.239218] [FACT gem_lmem_swapping (verify-ccs)] deleted: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[490.240544] [FACT gem_lmem_swapping (verify-ccs)] deleted: kernel.kmod_is_loaded.i915: true
[490.242459] [125/133] (542s left) gen9_exec_parse (batch-invalid-length)
[491.848748] Subtest batch-invalid-length: SKIP (0.000s)
[491.900892] [FACT gen9_exec_parse (batch-invalid-length)] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[491.903233] [FACT gen9_exec_parse (batch-invalid-length)] new: kernel.kmod_is_loaded.i915: true
[491.906395] [126/133] (540s left) gem_softpin (overlap)
[491.994505] Starting subtest: overlap
[495.198479] Subtest overlap: SUCCESS (3.204s)
[495.390415] [127/133] (537s left) kms_big_fb (4-tiled-8bpp-rotate-180)
[495.595450] Starting subtest: 4-tiled-8bpp-rotate-180
[497.164526] Subtest 4-tiled-8bpp-rotate-180: SUCCESS (1.568s)
[497.375742] [128/133] (535s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-32bpp-ytilercccs-downscaling)
[497.562297] Starting subtest: flip-64bpp-ytile-to-32bpp-ytilercccs-downscaling
[497.564148] Subtest flip-64bpp-ytile-to-32bpp-ytilercccs-downscaling: SKIP (0.000s)
[497.706270] [129/133] (535s left) kms_psr2_sf (psr2-primary-plane-update-sf-dmg-area)
[497.904349] Subtest psr2-primary-plane-update-sf-dmg-area: SKIP (0.000s)
[497.956721] [130/133] (534s left) i915_pm_freq_api (freq-suspend)
[498.044369] Starting subtest: freq-suspend
[498.045284] Starting dynamic subtest: gt0
[516.131661] Dynamic subtest gt0: SUCCESS (4.079s)
[516.132446] Subtest freq-suspend: SUCCESS (4.081s)
[516.257604] [131/133] (516s left) prime_busy (after)
[516.344396] Starting subtest: after
[516.349642] Starting dynamic subtest: rcs0
[516.395490] Dynamic subtest rcs0: SUCCESS (0.046s)
[516.406892] Starting dynamic subtest: bcs0
[516.464692] Dynamic subtest bcs0: SUCCESS (0.068s)
[516.491103] Starting dynamic subtest: vcs0
[516.511088] Dynamic subtest vcs0: SUCCESS (0.044s)
[516.537630] Starting dynamic subtest: vcs1
[516.553688] Dynamic subtest vcs1: SUCCESS (0.040s)
[516.572874] Starting dynamic subtest: vecs0
[516.593794] Dynamic subtest vecs0: SUCCESS (0.039s)
[516.610547] Starting dynamic subtest: vecs1
[516.633590] Dynamic subtest vecs1: SUCCESS (0.038s)
[516.650380] Starting dynamic subtest: ccs0
[516.674401] Dynamic subtest ccs0: SUCCESS (0.039s)
[516.782717] Subtest after: SUCCESS (0.438s)
[516.976946] [132/133] (516s left) gem_exec_whisper (basic-contexts-forked)
[517.066828] Starting subtest: basic-contexts-forked
[539.743647] Subtest basic-contexts-forked: SUCCESS (22.662s)
[540.029555] [133/133] (493s left) syncobj_timeline (etime-single-wait-all-for-submit-unsubmitted)
[540.103734] Starting subtest: etime-single-wait-all-for-submit-unsubmitted
[540.210774] Subtest etime-single-wait-all-for-submit-unsubmitted: SUCCESS (0.106s)
[540.449930] 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.