[57.403909] Initializing watchdogs
[57.403954]   /dev/watchdog0
[57.421738] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7d55 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Arc Graphics]
[57.426115] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[57.428343] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[57.431491] [001/131] (960s left) kms_ccs (crc-primary-suspend-4-tiled-dg2-rc-ccs-cc)
[57.542062] Starting subtest: crc-primary-suspend-4-tiled-dg2-rc-ccs-cc
[57.544319] Starting dynamic subtest: pipe-A-eDP-1
[57.553027] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[57.559479] Starting dynamic subtest: pipe-B-eDP-1
[57.568301] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[57.574971] Starting dynamic subtest: pipe-C-eDP-1
[57.583290] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[57.589079] Starting dynamic subtest: pipe-D-eDP-1
[57.597242] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[57.601156] Subtest crc-primary-suspend-4-tiled-dg2-rc-ccs-cc: SKIP (0.003s)
[59.721148] [002/131] (958s left) kms_cursor_legacy (cursorb-vs-flipa-varying-size)
[59.845306] Starting subtest: cursorB-vs-flipA-varying-size
[59.850088] Subtest cursorB-vs-flipA-varying-size: SKIP (0.001s)
[59.986898] [003/131] (958s left) gem_exec_balancer (invalid-balancer)
[60.053889] Starting subtest: invalid-balancer
[60.914246] Subtest invalid-balancer: SUCCESS (0.853s)
[61.214329] [004/131] (956s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-indfb-msflip-blt)
[61.322125] Starting subtest: fbcpsr-2p-primscrn-indfb-msflip-blt
[61.326278] Subtest fbcpsr-2p-primscrn-indfb-msflip-blt: SKIP (0.000s)
[61.423304] [005/131] (956s left) kms_feature_discovery (dp-mst)
[61.521852] Starting subtest: dp-mst
[61.526308] Subtest dp-mst: SKIP (0.000s)
[61.588491] [006/131] (956s left) kms_atomic_transition (plane-all-transition)
[61.679352] Starting subtest: plane-all-transition
[61.681635] Starting dynamic subtest: pipe-A-eDP-1
[64.190051] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.498s)
[64.495794] Starting dynamic subtest: pipe-B-eDP-1
[67.688337] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.190s)
[67.987740] Subtest plane-all-transition: SUCCESS (6.282s)
[68.805493] [007/131] (949s left) syncobj_timeline (etime-multi-wait-all-for-submit-submitted)
[68.862326] Starting subtest: etime-multi-wait-all-for-submit-submitted
[68.967952] Subtest etime-multi-wait-all-for-submit-submitted: SUCCESS (0.104s)
[69.036595] [008/131] (949s left) kms_flip (2x-modeset-vs-vblank-race-interruptible)
[69.143138] Starting subtest: 2x-modeset-vs-vblank-race-interruptible
[69.153346] Subtest 2x-modeset-vs-vblank-race-interruptible: SKIP (0.010s)
[69.279404] [009/131] (948s left) prime_mmap (test_forked)
[69.340420] Starting subtest: test_forked
[69.342854] Starting dynamic subtest: test_forked-smem
[69.381166] Dynamic subtest test_forked-smem: SUCCESS (0.041s)
[69.383597] Subtest test_forked: SUCCESS (0.042s)
[69.491567] [010/131] (948s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-32bpp-ytileccs-upscaling)
[69.587021] Starting subtest: flip-32bpp-ytile-to-32bpp-ytileccs-upscaling
[69.589348] Starting dynamic subtest: pipe-A-default-mode
[69.876162] Dynamic subtest pipe-A-default-mode: SKIP (0.285s)
[69.880927] Subtest flip-32bpp-ytile-to-32bpp-ytileccs-upscaling: SKIP (0.286s)
[70.729911] [011/131] (947s left) gem_exec_balancer (bonded-sync)
[70.826331] Starting subtest: bonded-sync
[70.831285] Subtest bonded-sync: SKIP (0.000s)
[71.405794] [012/131] (946s left) kms_ccs (crc-primary-basic-4-tiled-dg2-rc-ccs)
[71.622240] Starting subtest: crc-primary-basic-4-tiled-dg2-rc-ccs
[71.624715] Starting dynamic subtest: pipe-A-eDP-1
[71.649636] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[71.657865] Starting dynamic subtest: pipe-B-eDP-1
[71.679870] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[71.686612] Starting dynamic subtest: pipe-C-eDP-1
[71.708724] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[71.715449] Starting dynamic subtest: pipe-D-eDP-1
[71.738755] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[71.742986] Subtest crc-primary-basic-4-tiled-dg2-rc-ccs: SKIP (0.005s)
[73.785433] [013/131] (944s left) kms_psr (fbc-psr-cursor-mmap-gtt)
[73.880272] Starting subtest: fbc-psr-cursor-mmap-gtt
[73.882591] Starting dynamic subtest: eDP-1
[73.886853] Dynamic subtest eDP-1: SKIP (0.000s)
[73.891163] Subtest fbc-psr-cursor-mmap-gtt: SKIP (0.000s)
[73.948334] [014/131] (944s left) syncobj_wait (multi-wait-for-submit-signaled)
[74.005554] Starting subtest: multi-wait-for-submit-signaled
[74.007890] Subtest multi-wait-for-submit-signaled: SUCCESS (0.000s)
[74.113428] [015/131] (944s left) perf_pmu (module-unload)
[74.218352] Starting subtest: module-unload
[82.401168] Subtest module-unload: FAIL (8.066s)
[82.430217] [FACT perf_pmu (module-unload)] deleted: kernel.kmod_is_loaded.i915: true
[82.433622] [016/131] (936s left) kms_vblank (wait-forked)
[83.891804] Starting subtest: wait-forked
[83.894191] Starting dynamic subtest: pipe-A-eDP-1
[85.706253] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.810s)
[85.719122] Starting dynamic subtest: pipe-D-eDP-1
[88.211803] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.503s)
[88.214774] Subtest wait-forked: SUCCESS (4.316s)
[89.079346] [FACT kms_vblank (wait-forked)] new: kernel.kmod_is_loaded.i915: true
[89.083246] [017/131] (929s left) gem_exec_schedule (preempt-queue-contexts-chain)
[89.171164] Subtest preempt-queue-contexts-chain: SKIP (0.000s)
[89.460734] [018/131] (929s left) kms_big_fb (yf-tiled-64bpp-rotate-180)
[89.555136] Starting subtest: yf-tiled-64bpp-rotate-180
[89.559595] Subtest yf-tiled-64bpp-rotate-180: SKIP (0.000s)
[89.657746] [019/131] (928s left) kms_color (invalid-gamma-lut-sizes)
[89.751892] Starting subtest: invalid-gamma-lut-sizes
[89.754040] Starting dynamic subtest: pipe-A
[90.039702] Dynamic subtest pipe-A: SUCCESS (0.287s)
[90.047648] Starting dynamic subtest: pipe-B
[90.049991] Dynamic subtest pipe-B: SUCCESS (0.001s)
[90.057064] Starting dynamic subtest: pipe-C
[90.059407] Dynamic subtest pipe-C: SUCCESS (0.001s)
[90.067016] Starting dynamic subtest: pipe-D
[90.069380] Dynamic subtest pipe-D: SUCCESS (0.001s)
[90.071661] Subtest invalid-gamma-lut-sizes: SUCCESS (0.289s)
[90.899171] [020/131] (927s left) i915_drm_fdinfo (busy)
[90.937731] Starting subtest: busy
[90.939995] Starting dynamic subtest: rcs0
[90.974145] Dynamic subtest rcs0: SKIP (0.035s)
[90.984025] Starting dynamic subtest: bcs0
[90.988641] Dynamic subtest bcs0: SKIP (0.001s)
[90.997237] Starting dynamic subtest: vcs0
[91.001160] Dynamic subtest vcs0: SKIP (0.001s)
[91.007805] Starting dynamic subtest: vcs1
[91.014138] Dynamic subtest vcs1: SKIP (0.001s)
[91.020691] Starting dynamic subtest: vecs0
[91.024984] Dynamic subtest vecs0: SKIP (0.001s)
[91.031594] Starting dynamic subtest: ccs0
[91.035838] Dynamic subtest ccs0: SKIP (0.000s)
[91.041428] Subtest busy: SKIP (0.042s)
[91.074650] [021/131] (927s left) gem_render_copy (yf-tiled-ccs-to-yf-tiled-ccs)
[91.121095] Starting subtest: yf-tiled-ccs-to-yf-tiled-ccs
[91.125610] Subtest yf-tiled-ccs-to-yf-tiled-ccs: SKIP (0.000s)
[91.297389] [022/131] (927s left) kms_lease (setcrtc-implicit-plane)
[91.384056] Starting subtest: setcrtc-implicit-plane
[91.386494] Starting dynamic subtest: pipe-A-eDP-1
[91.860693] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.472s)
[91.869346] Starting dynamic subtest: pipe-B-eDP-1
[93.018651] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.160s)
[93.026984] Starting dynamic subtest: pipe-C-eDP-1
[94.133979] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.112s)
[94.144639] Starting dynamic subtest: pipe-D-eDP-1
[95.259728] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.127s)
[95.262319] Subtest setcrtc-implicit-plane: SUCCESS (3.874s)
[96.096280] [023/131] (922s left) i915_hangman (engine-engine-error)
[96.159956] Starting subtest: engine-engine-error
[96.162310] Starting dynamic subtest: rcs0
[97.844457] Dynamic subtest rcs0: SUCCESS (1.684s)
[97.854026] Starting dynamic subtest: bcs0
[99.891481] Dynamic subtest bcs0: SUCCESS (2.046s)
[99.901613] Starting dynamic subtest: vcs0
[101.873251] Dynamic subtest vcs0: SUCCESS (1.980s)
[101.887567] Starting dynamic subtest: vcs1
[103.860209] Dynamic subtest vcs1: SUCCESS (1.986s)
[103.870195] Starting dynamic subtest: vecs0
[105.843522] Dynamic subtest vecs0: SUCCESS (1.982s)
[105.854474] Starting dynamic subtest: ccs0
[107.891083] Dynamic subtest ccs0: SUCCESS (2.045s)
[107.893756] Subtest engine-engine-error: SUCCESS (11.729s)
[107.967651] [024/131] (910s left) gem_mmap_gtt (medium-copy)
[108.016031] Subtest medium-copy: SKIP (0.000s)
[108.081435] [025/131] (910s left) kms_pipe_crc_basic (suspend-read-crc)
[108.181131] Starting subtest: suspend-read-crc
[108.183417] Starting dynamic subtest: pipe-A-eDP-1
[125.566886] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.585s)
[125.575929] Starting dynamic subtest: pipe-B-eDP-1
[143.300026] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.790s)
[143.310958] Starting dynamic subtest: pipe-C-eDP-1
[161.232903] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.634s)
[161.242472] Starting dynamic subtest: pipe-D-eDP-1
[179.283116] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.739s)
[179.286177] Subtest suspend-read-crc: SUCCESS (10.754s)
[180.137051] [026/131] (838s left) kms_plane_scaling (planes-upscale-20x20-downscale-factor-0-75)
[180.234767] Starting subtest: planes-upscale-20x20-downscale-factor-0-75
[180.237229] Starting dynamic subtest: pipe-A
[180.255906] Dynamic subtest pipe-A: SKIP (0.016s)
[180.264552] Starting dynamic subtest: pipe-B
[180.285646] Dynamic subtest pipe-B: SKIP (0.028s)
[180.294115] Starting dynamic subtest: pipe-C
[180.313540] Dynamic subtest pipe-C: SKIP (0.028s)
[180.321477] Starting dynamic subtest: pipe-D
[180.341942] Dynamic subtest pipe-D: SKIP (0.028s)
[180.347006] Subtest planes-upscale-20x20-downscale-factor-0-75: SKIP (0.101s)
[180.445497] [027/131] (838s left) kms_atomic_interruptible (legacy-cursor)
[180.540686] Starting subtest: legacy-cursor
[180.543007] Starting dynamic subtest: pipe-A-eDP-1
[187.984673] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.340s)
[187.987692] Subtest legacy-cursor: SUCCESS (7.342s)
[188.814510] [028/131] (830s left) kms_draw_crc (draw-method-blt)
[188.912962] Starting subtest: draw-method-blt
[188.915726] Starting dynamic subtest: xrgb8888-untiled
[189.134497] Dynamic subtest xrgb8888-untiled: SUCCESS (0.222s)
[189.143103] Starting dynamic subtest: rgb565-untiled
[189.335987] Dynamic subtest rgb565-untiled: SUCCESS (0.200s)
[189.344961] Starting dynamic subtest: xrgb2101010-untiled
[189.525833] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.188s)
[189.534369] Starting dynamic subtest: xbgr16161616f-untiled
[189.727523] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.200s)
[189.736668] Starting dynamic subtest: xrgb8888-xtiled
[189.827888] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.100s)
[189.836632] Starting dynamic subtest: rgb565-xtiled
[189.929845] Dynamic subtest rgb565-xtiled: SUCCESS (0.099s)
[189.938353] Starting dynamic subtest: xrgb2101010-xtiled
[190.028528] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.100s)
[190.040671] Starting dynamic subtest: xbgr16161616f-xtiled
[190.118659] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (0.089s)
[190.126751] Starting dynamic subtest: xrgb8888-4tiled
[190.230720] Dynamic subtest xrgb8888-4tiled: SUCCESS (0.111s)
[190.238949] Starting dynamic subtest: rgb565-4tiled
[190.341885] Dynamic subtest rgb565-4tiled: SUCCESS (0.110s)
[190.350711] Starting dynamic subtest: xrgb2101010-4tiled
[190.431514] Dynamic subtest xrgb2101010-4tiled: SUCCESS (0.088s)
[190.440145] Starting dynamic subtest: xbgr16161616f-4tiled
[190.532060] Dynamic subtest xbgr16161616f-4tiled: SUCCESS (0.100s)
[190.534883] Subtest draw-method-blt: SUCCESS (1.611s)
[190.645474] [029/131] (828s left) gem_exec_reloc (basic-wc-gtt-noreloc)
[190.710533] Subtest basic-wc-gtt-noreloc: SKIP (0.000s)
[190.764841] [030/131] (828s left) gem_pread (exhaustion)
[190.823951] Subtest exhaustion: SKIP (0.000s)
[190.880690] [031/131] (828s left) kms_vblank (ts-continuation-idle-hang)
[190.975038] Starting subtest: ts-continuation-idle-hang
[190.977247] Starting dynamic subtest: pipe-A-eDP-1
[217.792427] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.776s)
[217.806073] Starting dynamic subtest: pipe-D-eDP-1
[242.827749] Dynamic subtest pipe-D-eDP-1: SUCCESS (25.031s)
[242.829951] Subtest ts-continuation-idle-hang: SUCCESS (51.812s)
[243.684821] [032/131] (775s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-mmap-gtt)
[243.797042] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-mmap-gtt
[243.802095] Subtest fbc-2p-scndscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[243.902586] [033/131] (775s left) gem_userptr_blits (map-fixed-invalidate)
[243.971813] Starting subtest: map-fixed-invalidate
[243.976715] Subtest map-fixed-invalidate: SKIP (0.000s)
[244.100952] [034/131] (775s left) gem_exec_reloc (basic-cpu-wc)
[244.160581] Subtest basic-cpu-wc: SKIP (0.000s)
[244.230772] [035/131] (774s left) kms_psr (fbc-psr-sprite-mmap-gtt)
[244.330834] Starting subtest: fbc-psr-sprite-mmap-gtt
[244.333325] Starting dynamic subtest: eDP-1
[244.337995] Dynamic subtest eDP-1: SKIP (0.000s)
[244.343241] Subtest fbc-psr-sprite-mmap-gtt: SKIP (0.001s)
[244.398336] [036/131] (774s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-180-async-flip)
[244.505203] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-180-async-flip
[245.151110] Subtest x-tiled-max-hw-stride-32bpp-rotate-180-async-flip: SUCCESS (0.648s)
[245.319534] [037/131] (773s left) gem_set_tiling_vs_gtt
[245.446505] [038/131] (773s left) kms_async_flips (test-time-stamp-atomic)
[245.545167] Starting subtest: test-time-stamp-atomic
[245.918580] Starting dynamic subtest: pipe-A-eDP-1
[246.690187] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.770s)
[247.066227] Starting dynamic subtest: pipe-B-eDP-1
[247.819042] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.757s)
[248.194026] Starting dynamic subtest: pipe-C-eDP-1
[248.949329] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.760s)
[249.311204] Starting dynamic subtest: pipe-D-eDP-1
[250.069749] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.764s)
[250.072073] Subtest test-time-stamp-atomic: SUCCESS (4.521s)
[251.212223] [039/131] (768s left) kms_frontbuffer_tracking (fbc-2p-indfb-fliptrack-mmap-gtt)
[251.314072] Starting subtest: fbc-2p-indfb-fliptrack-mmap-gtt
[251.319697] Subtest fbc-2p-indfb-fliptrack-mmap-gtt: SKIP (0.000s)
[251.413803] [040/131] (767s left) kms_flip (basic-flip-vs-modeset)
[251.515056] Starting subtest: basic-flip-vs-modeset
[251.517614] Starting dynamic subtest: A-eDP1
[254.108056] Dynamic subtest A-eDP1: SUCCESS (2.588s)
[254.121081] Starting dynamic subtest: B-eDP1
[256.247868] Dynamic subtest B-eDP1: SUCCESS (2.140s)
[256.257942] Starting dynamic subtest: C-eDP1
[258.404989] Dynamic subtest C-eDP1: SUCCESS (2.155s)
[258.415356] Starting dynamic subtest: D-eDP1
[260.546338] Dynamic subtest D-eDP1: SUCCESS (2.140s)
[260.548950] Subtest basic-flip-vs-modeset: SUCCESS (9.030s)
[261.342873] [041/131] (758s left) gem_mmap_gtt (basic)
[261.410224] Subtest basic: SKIP (0.000s)
[261.468321] [042/131] (757s left) kms_properties (crtc-properties-atomic)
[261.567604] Starting subtest: crtc-properties-atomic
[261.570055] Starting dynamic subtest: pipe-A-eDP-1
[262.031844] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.460s)
[262.045383] Starting dynamic subtest: pipe-B-eDP-1
[263.196753] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.165s)
[263.206399] Starting dynamic subtest: pipe-C-eDP-1
[264.323928] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.123s)
[264.335380] Starting dynamic subtest: pipe-D-eDP-1
[265.446332] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.123s)
[265.448691] Subtest crtc-properties-atomic: SUCCESS (3.876s)
[266.257977] [043/131] (753s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-mmap-gtt)
[266.365504] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-mmap-gtt
[266.369971] Subtest psr-2p-scndscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[266.462316] [044/131] (753s left) syncobj_wait (multi-wait-submitted)
[266.516064] Starting subtest: multi-wait-submitted
[266.616579] Subtest multi-wait-submitted: SUCCESS (0.103s)
[266.689243] [045/131] (752s left) kms_ccs (bad-pixel-format-4-tiled-dg2-rc-ccs)
[266.791590] Starting subtest: bad-pixel-format-4-tiled-dg2-rc-ccs
[266.793982] Starting dynamic subtest: pipe-A-eDP-1
[266.819533] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[266.827867] Starting dynamic subtest: pipe-B-eDP-1
[266.851944] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[266.859940] Starting dynamic subtest: pipe-C-eDP-1
[266.884650] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[266.892453] Starting dynamic subtest: pipe-D-eDP-1
[266.918498] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[266.922749] Subtest bad-pixel-format-4-tiled-dg2-rc-ccs: SKIP (0.005s)
[268.925410] [046/131] (750s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-indfb-msflip-blt)
[269.029626] Starting subtest: fbcpsr-2p-scndscrn-indfb-msflip-blt
[269.034524] Subtest fbcpsr-2p-scndscrn-indfb-msflip-blt: SKIP (0.000s)
[269.128302] [047/131] (750s left) kms_big_fb (y-tiled-16bpp-rotate-180)
[269.226506] Starting subtest: y-tiled-16bpp-rotate-180
[269.230701] Subtest y-tiled-16bpp-rotate-180: SKIP (0.000s)
[269.324196] [048/131] (750s left) kms_big_fb (linear-32bpp-rotate-180)
[269.418060] Starting subtest: linear-32bpp-rotate-180
[270.741070] Subtest linear-32bpp-rotate-180: SUCCESS (1.322s)
[270.880771] [049/131] (748s left) kms_chamelium_color (ctm-0-75)
[270.974792] Subtest ctm-0-75: SKIP (0.000s)
[271.018383] [050/131] (748s left) kms_atomic_transition (plane-use-after-nonblocking-unbind)
[271.110553] Starting subtest: plane-use-after-nonblocking-unbind
[271.112582] Starting dynamic subtest: pipe-A-eDP-1
[271.175392] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.064s)
[271.467975] Starting dynamic subtest: pipe-B-eDP-1
[272.219067] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.758s)
[272.515874] Subtest plane-use-after-nonblocking-unbind: SUCCESS (1.403s)
[273.372533] [051/131] (746s left) sw_sync (sync_busy)
[273.406788] Starting subtest: sync_busy
[273.409335] Subtest sync_busy: SUCCESS (0.002s)
[273.465364] [052/131] (746s left) gem_mmap_gtt (big-copy-odd)
[273.525996] Subtest big-copy-odd: SKIP (0.000s)
[273.592377] [053/131] (746s left) gem_render_copy (y-tiled-mc-ccs-to-y-tiled-ccs)
[273.652928] Starting subtest: y-tiled-mc-ccs-to-y-tiled-ccs
[273.658497] Subtest y-tiled-mc-ccs-to-y-tiled-ccs: SKIP (0.000s)
[273.840743] [054/131] (746s left) kms_concurrent (multi-plane-atomic-lowres)
[273.941921] Starting subtest: multi-plane-atomic-lowres
[273.945301] Starting dynamic subtest: pipe-A-eDP-1
[274.418111] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.476s)
[274.421072] Subtest multi-plane-atomic-lowres: SUCCESS (0.477s)
[275.198808] [055/131] (744s left) syncobj_timeline (invalid-transfer-illegal-handle)
[275.246734] Starting subtest: invalid-transfer-illegal-handle
[275.249352] Subtest invalid-transfer-illegal-handle: SUCCESS (0.000s)
[275.343669] [056/131] (744s left) kms_psr (psr2-sprite-blt)
[275.435768] Starting subtest: psr2-sprite-blt
[275.438077] Starting dynamic subtest: eDP-1
[277.092398] Dynamic subtest eDP-1: SUCCESS (1.656s)
[277.094855] Subtest psr2-sprite-blt: SUCCESS (1.657s)
[277.951083] [057/131] (742s left) kms_sequence (get-forked)
[278.053836] Starting subtest: get-forked
[278.056567] Starting dynamic subtest: pipe-A-eDP-1
[279.923979] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.867s)
[279.937809] Starting dynamic subtest: pipe-B-eDP-1
[282.468512] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.546s)
[282.478236] Starting dynamic subtest: pipe-C-eDP-1
[284.989325] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.518s)
[285.000365] Starting dynamic subtest: pipe-D-eDP-1
[287.511342] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.524s)
[287.513805] Subtest get-forked: SUCCESS (9.459s)
[288.359308] [058/131] (731s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-mmap-wc)
[288.451355] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-mmap-wc
[288.455826] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[288.550898] [059/131] (731s left) kms_psr (psr2-cursor-render)
[288.639657] Starting subtest: psr2-cursor-render
[288.641974] Starting dynamic subtest: eDP-1
[290.325242] Dynamic subtest eDP-1: SUCCESS (1.683s)
[290.327459] Subtest psr2-cursor-render: SUCCESS (1.684s)
[291.098871] [060/131] (729s left) kms_properties (connector-properties-legacy)
[291.191505] Starting subtest: connector-properties-legacy
[291.196914] Starting dynamic subtest: pipe-A-eDP-1
[299.045323] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.850s)
[299.053147] Starting dynamic subtest: pipe-None-DP-1
[299.057827] Dynamic subtest pipe-None-DP-1: SUCCESS (0.001s)
[299.066362] Starting dynamic subtest: pipe-None-HDMI-A-1
[299.070512] Dynamic subtest pipe-None-HDMI-A-1: SUCCESS (0.001s)
[299.078249] Starting dynamic subtest: pipe-None-DP-2
[299.082476] Dynamic subtest pipe-None-DP-2: SUCCESS (0.001s)
[299.090392] Starting dynamic subtest: pipe-None-HDMI-A-2
[299.095399] Dynamic subtest pipe-None-HDMI-A-2: SUCCESS (0.001s)
[299.105353] Starting dynamic subtest: pipe-None-DP-3
[299.110390] Dynamic subtest pipe-None-DP-3: SUCCESS (0.001s)
[299.119922] Starting dynamic subtest: pipe-None-DP-4
[299.125094] Dynamic subtest pipe-None-DP-4: SUCCESS (0.001s)
[299.127652] Subtest connector-properties-legacy: SUCCESS (7.861s)
[299.913347] [061/131] (720s left) kms_plane_scaling (plane-scaler-unity-scaling-with-rotation)
[300.013735] Starting subtest: plane-scaler-unity-scaling-with-rotation
[300.016288] Starting dynamic subtest: pipe-A
[300.254793] Dynamic subtest pipe-A: SUCCESS (0.240s)
[300.263568] Starting dynamic subtest: pipe-B
[301.495634] Dynamic subtest pipe-B: SUCCESS (1.241s)
[301.504099] Starting dynamic subtest: pipe-C
[302.817842] Dynamic subtest pipe-C: SUCCESS (1.321s)
[302.825948] Starting dynamic subtest: pipe-D
[304.145444] Dynamic subtest pipe-D: SUCCESS (1.327s)
[304.148658] Subtest plane-scaler-unity-scaling-with-rotation: SUCCESS (4.132s)
[305.324770] [062/131] (714s left) kms_chamelium_hpd (hdmi-hpd)
[305.714200] Subtest hdmi-hpd: SKIP (0.000s)
[306.527457] [063/131] (713s left) kms_prop_blob (invalid-set-prop)
[306.577995] Starting subtest: invalid-set-prop
[306.580620] Subtest invalid-set-prop: SUCCESS (0.000s)
[306.656319] [064/131] (713s left) kms_cursor_crc (cursor-suspend)
[306.796935] Starting subtest: cursor-suspend
[306.799429] Starting dynamic subtest: pipe-A-eDP-1
[339.094185] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.005s)
[339.103416] Starting dynamic subtest: pipe-D-eDP-1
[372.082300] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.562s)
[372.085148] Subtest cursor-suspend: SUCCESS (6.570s)
[372.900382] [065/131] (647s left) gem_ccs (ctrl-surf-copy-new-ctx)
[372.957857] Starting subtest: ctrl-surf-copy-new-ctx
[372.963482] Subtest ctrl-surf-copy-new-ctx: SKIP (0.000s)
[373.072693] [066/131] (647s left) kms_cursor_crc (cursor-onscreen-512x170)
[373.366453] Starting subtest: cursor-onscreen-512x170
[373.372667] Subtest cursor-onscreen-512x170: SKIP (0.001s)
[373.495242] [067/131] (646s left) kms_psr2_sf (psr2-plane-move-sf-dmg-area)
[378.537682] Starting subtest: psr2-plane-move-sf-dmg-area
[378.540430] Starting dynamic subtest: pipe-A-eDP-1
[383.851401] Dynamic subtest pipe-A-eDP-1: SUCCESS (5.265s)
[383.861258] Starting dynamic subtest: pipe-B-eDP-1
[389.175510] Dynamic subtest pipe-B-eDP-1: SUCCESS (5.310s)
[389.178056] Subtest psr2-plane-move-sf-dmg-area: SUCCESS (10.580s)
[390.036867] [068/131] (630s left) gem_exec_create (basic)
[390.107557] Starting subtest: basic
[390.110303] Starting dynamic subtest: smem
[393.691603] Dynamic subtest smem: SUCCESS (3.577s)
[393.694450] Subtest basic: SUCCESS (3.579s)
[393.872093] [069/131] (626s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-pwrite)
[393.975618] Starting subtest: fbcpsr-rgb565-draw-pwrite
[400.961347] Subtest fbcpsr-rgb565-draw-pwrite: SUCCESS (6.981s)
[401.107622] [070/131] (619s left) gem_mmap_wc (write-wc-read-gtt)
[401.160176] Subtest write-wc-read-gtt: SKIP (0.000s)
[401.215000] [071/131] (619s left) kms_psr2_sf (fbc-psr2-cursor-plane-update-sf)
[406.200573] Starting subtest: fbc-psr2-cursor-plane-update-sf
[406.203498] Starting dynamic subtest: pipe-A-eDP-1
[406.995617] Dynamic subtest pipe-A-eDP-1: SKIP (0.792s)
[407.005432] Starting dynamic subtest: pipe-B-eDP-1
[408.120298] Dynamic subtest pipe-B-eDP-1: SKIP (1.120s)
[408.124826] Subtest fbc-psr2-cursor-plane-update-sf: SKIP (1.916s)
[409.293601] [072/131] (611s left) kms_rotation_crc (sprite-rotation-180)
[409.380390] Starting subtest: sprite-rotation-180
[414.552156] Subtest sprite-rotation-180: SUCCESS (5.166s)
[415.745474] [073/131] (604s left) i915_pm_rpm (gem-execbuf-stress-pc8)
[417.887658] Starting subtest: gem-execbuf-stress-pc8
[417.926961] Subtest gem-execbuf-stress-pc8: SKIP (0.040s)
[418.243965] [074/131] (602s left) gem_exec_schedule (noreorder)
[418.423983] Starting subtest: noreorder
[418.426193] Starting dynamic subtest: rcs0
[418.510875] Dynamic subtest rcs0: SUCCESS (0.084s)
[418.521277] Starting dynamic subtest: vcs0
[419.698301] Dynamic subtest vcs0: SUCCESS (1.186s)
[419.709616] Starting dynamic subtest: vcs1
[421.747316] Dynamic subtest vcs1: SUCCESS (2.045s)
[421.763588] Starting dynamic subtest: vecs0
[423.742925] Dynamic subtest vecs0: SUCCESS (1.993s)
[423.752109] Starting dynamic subtest: ccs0
[423.838268] Dynamic subtest ccs0: SUCCESS (0.095s)
[423.840726] Subtest noreorder: SUCCESS (5.412s)
[424.024830] [075/131] (596s left) syncobj_timeline (multi-wait-for-submit-available-signaled)
[424.072265] Starting subtest: multi-wait-for-submit-available-signaled
[424.074638] Subtest multi-wait-for-submit-available-signaled: SUCCESS (0.000s)
[424.173732] [076/131] (596s left) gem_ctx_persistence (saturated-hostile)
[424.229043] Starting subtest: saturated-hostile
[424.231470] Starting dynamic subtest: rcs0
[425.094099] Dynamic subtest rcs0: SUCCESS (0.864s)
[425.105881] Starting dynamic subtest: bcs0
[425.916583] Dynamic subtest bcs0: SUCCESS (0.821s)
[425.926344] Starting dynamic subtest: vcs0
[426.736254] Dynamic subtest vcs0: SUCCESS (0.817s)
[426.748517] Starting dynamic subtest: vcs1
[427.541352] Dynamic subtest vcs1: SUCCESS (0.804s)
[427.550645] Starting dynamic subtest: vecs0
[428.351100] Dynamic subtest vecs0: SUCCESS (0.808s)
[428.361660] Starting dynamic subtest: ccs0
[429.208274] Dynamic subtest ccs0: SUCCESS (0.854s)
[429.210874] Subtest saturated-hostile: SUCCESS (4.977s)
[429.285076] [077/131] (591s left) gem_exec_params (invalid-batch-start-offset)
[429.344443] Starting subtest: invalid-batch-start-offset
[429.350271] Subtest invalid-batch-start-offset: SUCCESS (0.003s)
[429.468703] [078/131] (591s left) kms_psr2_su (frontbuffer-xrgb8888)
[429.528890] Subtest frontbuffer-XRGB8888: SKIP (0.000s)
[429.584562] [079/131] (591s left) kms_invalid_mode (bad-vsync-end)
[429.679274] Starting subtest: bad-vsync-end
[429.681650] Starting dynamic subtest: pipe-A-eDP-1
[429.983254] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.301s)
[429.992257] Starting dynamic subtest: pipe-B-eDP-1
[429.994537] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[430.002803] Starting dynamic subtest: pipe-C-eDP-1
[430.005243] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[430.013478] Starting dynamic subtest: pipe-D-eDP-1
[430.015876] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[430.017900] Subtest bad-vsync-end: SUCCESS (0.308s)
[430.794330] [080/131] (590s left) gem_exec_fence (nb-await)
[430.977640] Starting subtest: nb-await
[430.980545] Starting dynamic subtest: rcs0
[431.049652] Dynamic subtest rcs0: SUCCESS (0.071s)
[431.061661] Starting dynamic subtest: bcs0
[431.107652] Dynamic subtest bcs0: SUCCESS (0.056s)
[431.117654] Starting dynamic subtest: vcs0
[431.166501] Dynamic subtest vcs0: SUCCESS (0.057s)
[431.176399] Starting dynamic subtest: vcs1
[431.224608] Dynamic subtest vcs1: SUCCESS (0.056s)
[431.235654] Starting dynamic subtest: vecs0
[431.283041] Dynamic subtest vecs0: SUCCESS (0.056s)
[431.295279] Starting dynamic subtest: ccs0
[431.341001] Dynamic subtest ccs0: SUCCESS (0.056s)
[431.343416] Subtest nb-await: SUCCESS (0.364s)
[432.764244] [FACT gem_exec_fence (nb-await)] new: kernel.kmod_is_loaded.vgem: true
[432.767977] [081/131] (588s left) kms_addfb_basic (bad-pitch-32)
[432.820621] Starting subtest: bad-pitch-32
[432.823445] Subtest bad-pitch-32: SUCCESS (0.000s)
[432.960365] [082/131] (588s left) kms_frontbuffer_tracking (psr-2p-primscrn-shrfb-plflip-blt)
[433.066295] Starting subtest: psr-2p-primscrn-shrfb-plflip-blt
[433.071427] Subtest psr-2p-primscrn-shrfb-plflip-blt: SKIP (0.000s)
[433.159852] [083/131] (587s left) gem_close (basic)
[433.216496] Starting subtest: basic
[433.219053] Subtest basic: SUCCESS (0.000s)
[433.312056] [084/131] (587s left) kms_cursor_legacy (2x-cursor-vs-flip-atomic)
[433.421239] Starting subtest: 2x-cursor-vs-flip-atomic
[433.426428] Subtest 2x-cursor-vs-flip-atomic: SKIP (0.001s)
[433.570642] [085/131] (587s left) intel_hwmon (hwmon-read)
[433.630597] Subtest hwmon-read: SKIP (0.000s)
[433.698383] [086/131] (587s left) kms_frontbuffer_tracking (psr-1p-rte)
[433.794013] Starting subtest: psr-1p-rte
[439.186353] Subtest psr-1p-rte: SUCCESS (5.391s)
[439.346158] [087/131] (581s left) drm_read (invalid-buffer)
[439.498986] Starting subtest: invalid-buffer
[439.501306] Subtest invalid-buffer: SUCCESS (0.000s)
[439.646135] [088/131] (581s left) kms_cursor_edge_walk (64x64-top-bottom)
[439.738288] Starting subtest: 64x64-top-bottom
[439.740894] Starting dynamic subtest: pipe-A-eDP-1
[443.137211] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.393s)
[443.149454] Starting dynamic subtest: pipe-D-eDP-1
[446.266338] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.128s)
[446.269500] Subtest 64x64-top-bottom: SUCCESS (6.524s)
[447.065110] [089/131] (574s left) gem_mmap_wc (read-write-distinct)
[447.133526] Subtest read-write-distinct: SKIP (0.000s)
[447.201803] [090/131] (574s left) syncobj_timeline (etime-multi-wait-for-submit-unsubmitted)
[447.261040] Starting subtest: etime-multi-wait-for-submit-unsubmitted
[447.366993] Subtest etime-multi-wait-for-submit-unsubmitted: SUCCESS (0.106s)
[447.443278] [091/131] (573s left) kms_getfb (getfb2-accept-nv12)
[447.528741] Starting subtest: getfb2-accept-nv12
[447.531458] Subtest getfb2-accept-nv12: SUCCESS (0.001s)
[447.634871] [092/131] (573s left) kms_getfb (getfb-handle-not-fb)
[447.731199] Starting subtest: getfb-handle-not-fb
[447.733465] Subtest getfb-handle-not-fb: SUCCESS (0.000s)
[447.851475] [093/131] (573s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-render)
[447.947621] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-render
[447.952072] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-render: SKIP (0.000s)
[448.041128] [094/131] (573s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-render)
[448.144914] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-render
[451.860615] Subtest fbc-1p-primscrn-cur-indfb-draw-render: SUCCESS (3.719s)
[453.042799] [095/131] (568s left) prime_vgem (coherency-blt)
[453.129368] Starting subtest: coherency-blt
[454.209860] Subtest coherency-blt: SUCCESS (1.080s)
[454.347119] [096/131] (567s left) gem_ctx_persistence (engines-hostile-preempt)
[454.406262] Starting subtest: engines-hostile-preempt
[454.408501] Starting dynamic subtest: rcs0
[454.477077] Dynamic subtest rcs0: SUCCESS (0.070s)
[454.488111] Starting dynamic subtest: bcs0
[454.541736] Dynamic subtest bcs0: SUCCESS (0.063s)
[454.554925] Starting dynamic subtest: vcs0
[455.729071] Dynamic subtest vcs0: SUCCESS (1.185s)
[455.740456] Starting dynamic subtest: vcs1
[457.704254] Dynamic subtest vcs1: SUCCESS (1.974s)
[457.715621] Starting dynamic subtest: vecs0
[459.657126] Dynamic subtest vecs0: SUCCESS (1.952s)
[459.668935] Starting dynamic subtest: ccs0
[459.783995] Dynamic subtest ccs0: SUCCESS (0.126s)
[459.786800] Subtest engines-hostile-preempt: SUCCESS (5.380s)
[459.866125] [097/131] (561s left) syncobj_timeline (wait-zero-handles)
[459.918013] Starting subtest: wait-zero-handles
[459.920469] Subtest wait-zero-handles: SUCCESS (0.000s)
[460.012426] [098/131] (561s left) syncobj_timeline (wait-all-delayed-signal)
[460.070655] Starting subtest: wait-all-delayed-signal
[460.169956] Subtest wait-all-delayed-signal: SUCCESS (0.102s)
[460.254100] [099/131] (561s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-mmap-wc)
[460.367618] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-mmap-wc
[467.138230] Subtest psr-1p-primscrn-pri-shrfb-draw-mmap-wc: SUCCESS (6.777s)
[467.245743] [100/131] (554s left) gem_exec_schedule (u-semaphore-resolve)
[467.318272] Starting subtest: u-semaphore-resolve
[467.359367] Subtest u-semaphore-resolve: SUCCESS (0.053s)
[467.697450] [101/131] (554s left) kms_properties (get_properties-sanity-non-atomic)
[467.794344] Starting subtest: get_properties-sanity-non-atomic
[467.797159] Subtest get_properties-sanity-non-atomic: SUCCESS (0.001s)
[467.871864] [102/131] (553s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-mmap-wc)
[467.983500] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-mmap-wc
[467.988320] Subtest fbc-2p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[468.090617] [103/131] (553s left) kms_pm_rpm (cursor-dpms)
[469.819953] Starting subtest: cursor-dpms
[469.825541] Subtest cursor-dpms: SKIP (0.000s)
[470.335754] [104/131] (551s left) device_reset (unbind-reset-rebind)
[470.378786] Starting subtest: unbind-reset-rebind
[475.036598] Subtest unbind-reset-rebind: SUCCESS (4.653s)
[475.079012] [105/131] (546s left) kms_frontbuffer_tracking (psr-suspend)
[475.179241] Starting subtest: psr-suspend
[512.914756] Subtest psr-suspend: SUCCESS (7.513s)
[513.022159] [106/131] (508s left) api_intel_allocator (fork-simple-stress-signal)
[513.085409] Starting subtest: fork-simple-stress-signal
[518.590235] Subtest fork-simple-stress-signal: SUCCESS (5.402s)
[518.719320] [107/131] (503s left) kms_big_fb (4-tiled-64bpp-rotate-90)
[518.846554] Starting subtest: 4-tiled-64bpp-rotate-90
[518.866341] Subtest 4-tiled-64bpp-rotate-90: SKIP (0.019s)
[518.984066] [108/131] (503s left) kms_cursor_legacy (cursor-vs-flip-atomic)
[519.112746] Starting subtest: cursor-vs-flip-atomic
[548.563851] Subtest cursor-vs-flip-atomic: SUCCESS (29.359s)
[549.360403] [109/131] (472s left) gem_exec_params (no-bsd)
[549.426217] Starting subtest: no-bsd
[549.428718] Subtest no-bsd: SUCCESS (0.003s)
[551.025409] [110/131] (471s left) kms_frontbuffer_tracking (fbc-rgb565-draw-mmap-wc)
[551.121682] Starting subtest: fbc-rgb565-draw-mmap-wc
[555.194563] Subtest fbc-rgb565-draw-mmap-wc: SUCCESS (4.080s)
[556.347608] [111/131] (465s left) kms_ccs (crc-sprite-planes-basic-4-tiled-mtl-rc-ccs)
[556.441418] Starting subtest: crc-sprite-planes-basic-4-tiled-mtl-rc-ccs
[556.443751] Starting dynamic subtest: pipe-A-eDP-1
[556.926499] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.451s)
[556.936381] Starting dynamic subtest: pipe-B-eDP-1
[558.327467] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.404s)
[558.336937] Starting dynamic subtest: pipe-C-eDP-1
[559.726836] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.396s)
[559.736788] Starting dynamic subtest: pipe-D-eDP-1
[561.057549] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.328s)
[561.060174] Subtest crc-sprite-planes-basic-4-tiled-mtl-rc-ccs: SUCCESS (4.583s)
[562.243528] [112/131] (460s left) kms_ccs (missing-ccs-buffer-y-tiled-gen12-mc-ccs)
[562.341967] Starting subtest: missing-ccs-buffer-y-tiled-gen12-mc-ccs
[562.344925] Starting dynamic subtest: pipe-A-eDP-1
[562.371383] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[562.382869] Starting dynamic subtest: pipe-B-eDP-1
[562.408696] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[562.418531] Starting dynamic subtest: pipe-C-eDP-1
[562.440909] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[562.450067] Starting dynamic subtest: pipe-D-eDP-1
[562.472415] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[562.476467] Subtest missing-ccs-buffer-y-tiled-gen12-mc-ccs: SKIP (0.004s)
[564.496526] [113/131] (457s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-render)
[564.614699] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-render
[571.260415] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-render: SUCCESS (6.650s)
[571.395428] [114/131] (450s left) prime_mmap_coherency (read)
[571.460364] Starting subtest: read
[576.838964] Subtest read: SUCCESS (5.376s)
[576.982683] [115/131] (445s left) gem_ctx_param (invalid-get-engines)
[577.047432] Starting subtest: invalid-get-engines
[577.050181] Subtest invalid-get-engines: SUCCESS (0.001s)
[577.165660] [116/131] (445s left) perf (gen12-mi-rpc)
[577.266202] Starting subtest: gen12-mi-rpc
[577.268682] Starting dynamic subtest: rcs0
[577.290551] Dynamic subtest rcs0: SUCCESS (0.022s)
[577.293134] Subtest gen12-mi-rpc: SUCCESS (0.022s)
[577.335066] [117/131] (445s left) kms_busy (extended-modeset-hang-newfb)
[577.452063] Starting subtest: extended-modeset-hang-newfb
[577.454603] Starting dynamic subtest: pipe-A
[611.817574] Dynamic subtest pipe-A: SUCCESS (34.355s)
[611.827508] Starting dynamic subtest: pipe-D
[634.751331] Dynamic subtest pipe-D: SUCCESS (22.934s)
[634.754341] Subtest extended-modeset-hang-newfb: SUCCESS (57.294s)
[635.540301] [118/131] (386s left) gem_mmap_gtt (cpuset-medium-copy-xy)
[635.589824] Subtest cpuset-medium-copy-XY: SKIP (0.000s)
[635.654406] [119/131] (386s left) drm_mm (drm_mm)
[635.685437] Starting subtest: drm_mm
[635.722329] Starting dynamic subtest: drm_test_mm_init
[635.866133] Dynamic subtest drm_test_mm_init: SUCCESS (0.144s)
[635.877826] Starting dynamic subtest: drm_test_mm_debug
[636.012064] Dynamic subtest drm_test_mm_debug: SUCCESS (0.146s)
[636.024824] Starting dynamic subtest: drm_test_mm_align32
[636.105935] Dynamic subtest drm_test_mm_align32: SUCCESS (0.093s)
[636.116836] Starting dynamic subtest: drm_test_mm_align64
[636.257521] Dynamic subtest drm_test_mm_align64: SUCCESS (0.150s)
[636.269535] Starting dynamic subtest: drm_test_mm_lowest
[636.395649] Dynamic subtest drm_test_mm_lowest: SUCCESS (0.135s)
[636.405626] Starting dynamic subtest: drm_test_mm_highest
[636.523282] Dynamic subtest drm_test_mm_highest: SUCCESS (0.128s)
[636.525854] Subtest drm_mm: SUCCESS (0.838s)
[636.743750] [120/131] (385s left) api_intel_bb (intel-bb-blit-y)
[636.806301] Starting subtest: intel-bb-blit-y
[640.229546] Subtest intel-bb-blit-y: SUCCESS (3.423s)
[640.366360] [121/131] (382s left) perf (create-destroy-userspace-config)
[640.452528] Starting subtest: create-destroy-userspace-config
[640.470818] Subtest create-destroy-userspace-config: SUCCESS (0.016s)
[640.511000] [122/131] (382s left) gem_spin_batch (resubmit)
[640.567662] Starting subtest: resubmit
[640.570277] Starting dynamic subtest: rcs0
[640.581609] Dynamic subtest rcs0: SUCCESS (0.013s)
[640.592732] Starting dynamic subtest: bcs0
[640.595048] Dynamic subtest bcs0: SUCCESS (0.004s)
[640.604817] Starting dynamic subtest: vcs0
[640.607441] Dynamic subtest vcs0: SUCCESS (0.004s)
[640.616831] Starting dynamic subtest: vcs1
[640.619112] Dynamic subtest vcs1: SUCCESS (0.004s)
[640.628646] Starting dynamic subtest: vecs0
[640.630852] Dynamic subtest vecs0: SUCCESS (0.003s)
[640.639544] Starting dynamic subtest: ccs0
[640.641703] Dynamic subtest ccs0: SUCCESS (0.006s)
[640.644094] Subtest resubmit: SUCCESS (0.038s)
[640.854730] [123/131] (381s left) perf (rc6-disable)
[640.924813] Starting subtest: rc6-disable
[641.142519] Subtest rc6-disable: SUCCESS (0.218s)
[641.189901] [124/131] (381s left) kms_plane_alpha_blend (constant-alpha-min)
[641.290518] Starting subtest: constant-alpha-min
[641.571390] Starting dynamic subtest: pipe-A-eDP-1
[642.260585] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.687s)
[642.271747] Starting dynamic subtest: pipe-D-eDP-1
[643.708407] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.446s)
[643.710936] Subtest constant-alpha-min: SUCCESS (2.415s)
[644.583697] [125/131] (378s left) kms_big_fb (linear-addfb)
[644.688488] Starting subtest: linear-addfb
[644.690728] Subtest linear-addfb: SUCCESS (0.000s)
[644.800210] [126/131] (378s left) gem_create (create-invalid-size)
[644.849577] Starting subtest: create-invalid-size
[644.851867] Subtest create-invalid-size: SUCCESS (0.000s)
[645.035116] [127/131] (377s left) gem_vm_create (isolation)
[645.092763] Starting subtest: isolation
[645.101079] Subtest isolation: SUCCESS (0.009s)
[645.233431] [128/131] (377s left) gem_huc_copy (huc-copy)
[645.295630] Starting subtest: huc-copy
[645.300564] Subtest huc-copy: SUCCESS (0.004s)
[645.453383] [129/131] (377s left) gem_lmem_swapping (heavy-verify-random)
[645.497601] Subtest heavy-verify-random: SKIP (0.000s)
[645.540642] [130/131] (377s left) i915_pm_rpm (system-suspend-execbuf)
[647.071665] Starting subtest: system-suspend-execbuf
[708.540117] Subtest system-suspend-execbuf: SUCCESS (46.691s)
[708.908313] [131/131] (314s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-mmap-gtt)
[709.012551] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-mmap-gtt
[709.016825] Subtest fbc-1p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[709.111024] Closing watchdogs
results: parsing output: 0/ for test: kms_ccs
results: parsing output: 1/ for test: kms_cursor_legacy
results: parsing output: 2/ for test: gem_exec_balancer
results: parsing output: 3/ for test: kms_frontbuffer_tracking
results: parsing output: 4/ for test: kms_feature_discovery
results: parsing output: 5/ for test: kms_atomic_transition
results: parsing output: 6/ for test: syncobj_timeline
results: parsing output: 7/ for test: kms_flip
results: parsing output: 8/ for test: prime_mmap
results: parsing output: 9/ for test: kms_flip_scaled_crc
results: parsing output: 10/ for test: gem_exec_balancer
results: parsing output: 11/ for test: kms_ccs
results: parsing output: 12/ for test: kms_psr
results: parsing output: 13/ for test: syncobj_wait
results: parsing output: 14/ for test: perf_pmu
results: parsing output: 15/ for test: kms_vblank
results: parsing output: 16/ for test: gem_exec_schedule
results: parsing output: 17/ for test: kms_big_fb
results: parsing output: 18/ for test: kms_color
results: parsing output: 19/ for test: i915_drm_fdinfo
results: parsing output: 20/ for test: gem_render_copy
results: parsing output: 21/ for test: kms_lease
results: parsing output: 22/ for test: i915_hangman
results: parsing output: 23/ for test: gem_mmap_gtt
results: parsing output: 24/ for test: kms_pipe_crc_basic
results: parsing output: 25/ for test: kms_plane_scaling
results: parsing output: 26/ for test: kms_atomic_interruptible
results: parsing output: 27/ for test: kms_draw_crc
results: parsing output: 28/ for test: gem_exec_reloc
results: parsing output: 29/ for test: gem_pread
results: parsing output: 30/ for test: kms_vblank
results: parsing output: 31/ for test: kms_frontbuffer_tracking
results: parsing output: 32/ for test: gem_userptr_blits
results: parsing output: 33/ for test: gem_exec_reloc
results: parsing output: 34/ for test: kms_psr
results: parsing output: 35/ for test: kms_big_fb
results: parsing output: 36/ for test: gem_set_tiling_vs_gtt
results: parsing output: 37/ for test: kms_async_flips
results: parsing output: 38/ for test: kms_frontbuffer_tracking
results: parsing output: 39/ for test: kms_flip
results: parsing output: 40/ for test: gem_mmap_gtt
results: parsing output: 41/ for test: kms_properties
results: parsing output: 42/ for test: kms_frontbuffer_tracking
results: parsing output: 43/ for test: syncobj_wait
results: parsing output: 44/ for test: kms_ccs
results: parsing output: 45/ for test: kms_frontbuffer_tracking
results: parsing output: 46/ for test: kms_big_fb
results: parsing output: 47/ for test: kms_big_fb
results: parsing output: 48/ for test: kms_chamelium_color
results: parsing output: 49/ for test: kms_atomic_transition
results: parsing output: 50/ for test: sw_sync
results: parsing output: 51/ for test: gem_mmap_gtt
results: parsing output: 52/ for test: gem_render_copy
results: parsing output: 53/ for test: kms_concurrent
results: parsing output: 54/ for test: syncobj_timeline
results: parsing output: 55/ for test: kms_psr
results: parsing output: 56/ for test: kms_sequence
results: parsing output: 57/ for test: kms_frontbuffer_tracking
results: parsing output: 58/ for test: kms_psr
results: parsing output: 59/ for test: kms_properties
results: parsing output: 60/ for test: kms_plane_scaling
results: parsing output: 61/ for test: kms_chamelium_hpd
results: parsing output: 62/ for test: kms_prop_blob
results: parsing output: 63/ for test: kms_cursor_crc
results: parsing output: 64/ for test: gem_ccs
results: parsing output: 65/ for test: kms_cursor_crc
results: parsing output: 66/ for test: kms_psr2_sf
results: parsing output: 67/ for test: gem_exec_create
results: parsing output: 68/ for test: kms_frontbuffer_tracking
results: parsing output: 69/ for test: gem_mmap_wc
results: parsing output: 70/ for test: kms_psr2_sf
results: parsing output: 71/ for test: kms_rotation_crc
results: parsing output: 72/ for test: i915_pm_rpm
results: parsing output: 73/ for test: gem_exec_schedule
results: parsing output: 74/ for test: syncobj_timeline
results: parsing output: 75/ for test: gem_ctx_persistence
results: parsing output: 76/ for test: gem_exec_params
results: parsing output: 77/ for test: kms_psr2_su
results: parsing output: 78/ for test: kms_invalid_mode
results: parsing output: 79/ for test: gem_exec_fence
results: parsing output: 80/ for test: kms_addfb_basic
results: parsing output: 81/ for test: kms_frontbuffer_tracking
results: parsing output: 82/ for test: gem_close
results: parsing output: 83/ for test: kms_cursor_legacy
results: parsing output: 84/ for test: intel_hwmon
results: parsing output: 85/ for test: kms_frontbuffer_tracking
results: parsing output: 86/ for test: drm_read
results: parsing output: 87/ for test: kms_cursor_edge_walk
results: parsing output: 88/ for test: gem_mmap_wc
results: parsing output: 89/ for test: syncobj_timeline
results: parsing output: 90/ for test: kms_getfb
results: parsing output: 91/ for test: kms_getfb
results: parsing output: 92/ for test: kms_frontbuffer_tracking
results: parsing output: 93/ for test: kms_frontbuffer_tracking
results: parsing output: 94/ for test: prime_vgem
results: parsing output: 95/ for test: gem_ctx_persistence
results: parsing output: 96/ for test: syncobj_timeline
results: parsing output: 97/ for test: syncobj_timeline
results: parsing output: 98/ for test: kms_frontbuffer_tracking
results: parsing output: 99/ for test: gem_exec_schedule
results: parsing output: 100/ for test: kms_properties
results: parsing output: 101/ for test: kms_frontbuffer_tracking
results: parsing output: 102/ for test: kms_pm_rpm
results: parsing output: 103/ for test: device_reset
results: parsing output: 104/ for test: kms_frontbuffer_tracking
results: parsing output: 105/ for test: api_intel_allocator
results: parsing output: 106/ for test: kms_big_fb
results: parsing output: 107/ for test: kms_cursor_legacy
results: parsing output: 108/ for test: gem_exec_params
results: parsing output: 109/ for test: kms_frontbuffer_tracking
results: parsing output: 110/ for test: kms_ccs
results: parsing output: 111/ for test: kms_ccs
results: parsing output: 112/ for test: kms_frontbuffer_tracking
results: parsing output: 113/ for test: prime_mmap_coherency
results: parsing output: 114/ for test: gem_ctx_param
results: parsing output: 115/ for test: perf
results: parsing output: 116/ for test: kms_busy
results: parsing output: 117/ for test: gem_mmap_gtt
results: parsing output: 118/ for test: drm_mm
results: parsing output: 119/ for test: api_intel_bb
results: parsing output: 120/ for test: perf
results: parsing output: 121/ for test: gem_spin_batch
results: parsing output: 122/ for test: perf
results: parsing output: 123/ for test: kms_plane_alpha_blend
results: parsing output: 124/ for test: kms_big_fb
results: parsing output: 125/ for test: gem_create
results: parsing output: 126/ for test: gem_vm_create
results: parsing output: 127/ for test: gem_huc_copy
results: parsing output: 128/ for test: gem_lmem_swapping
results: parsing output: 129/ for test: i915_pm_rpm
results: parsing output: 130/ for test: kms_frontbuffer_tracking
Done.