[66.853397] Initializing watchdogs
[66.853475]   /dev/watchdog0
[66.883676] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:03:00.0: 8086:4905 Intel Dg1 (Gen12) DG1 [Iris Xe MAX Graphics]
[66.897881] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[66.902535] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[66.906014] [001/133] (960s left) kms_content_protection (dp-mst-lic-type-0-hdcp14)
[68.469439] Starting subtest: dp-mst-lic-type-0-hdcp14
[68.473041] Subtest dp-mst-lic-type-0-hdcp14: SKIP (0.000s)
[68.674682] [002/133] (958s left) core_getversion (all-cards)
[68.720893] Starting subtest: all-cards
[68.738924] Subtest all-cards: SUCCESS (0.020s)
[68.802070] [003/133] (958s left) kms_atomic_interruptible (legacy-dpms)
[70.290722] Starting subtest: legacy-dpms
[70.292325] Starting dynamic subtest: pipe-A-HDMI-A-4
[76.494482] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (6.194s)
[76.495890] Subtest legacy-dpms: SUCCESS (6.196s)
[76.682841] [004/133] (950s left) kms_plane (pixel-format-y-tiled-ccs-modifier-source-clamping)
[78.165957] Starting subtest: pixel-format-y-tiled-ccs-modifier-source-clamping
[78.174353] Subtest pixel-format-y-tiled-ccs-modifier-source-clamping: SKIP (0.000s)
[78.360274] [005/133] (949s left) kms_atomic_transition (plane-primary-toggle-with-vblank-wait)
[79.848116] Starting subtest: plane-primary-toggle-with-vblank-wait
[79.849542] Starting dynamic subtest: pipe-A-HDMI-A-4
[80.062406] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (0.213s)
[80.205344] Starting dynamic subtest: pipe-B-HDMI-A-4
[80.434044] Dynamic subtest pipe-B-HDMI-A-4: SUCCESS (0.238s)
[80.490211] Subtest plane-primary-toggle-with-vblank-wait: SUCCESS (0.643s)
[80.723424] [006/133] (947s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-mmap-gtt)
[82.214576] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-mmap-gtt
[82.217367] Subtest fbc-2p-scndscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[82.432112] [007/133] (945s left) kms_psr (fbc-psr2-primary-mmap-cpu)
[83.916245] Subtest fbc-psr2-primary-mmap-cpu: SKIP (0.000s)
[83.980417] [008/133] (944s left) perf (invalid-oa-exponent)
[84.147381] Starting subtest: invalid-oa-exponent
[84.174598] Subtest invalid-oa-exponent: SUCCESS (0.027s)
[84.232370] [009/133] (943s left) gem_eio (create-ext)
[84.371920] Starting subtest: create-ext
[84.548529] Subtest create-ext: SUCCESS (0.178s)
[86.129959] [010/133] (942s left) kms_color (invalid-degamma-lut-sizes)
[87.629350] Starting subtest: invalid-degamma-lut-sizes
[87.630739] Starting dynamic subtest: pipe-A
[87.668913] Dynamic subtest pipe-A: SUCCESS (0.040s)
[87.678073] Starting dynamic subtest: pipe-B
[87.679531] Dynamic subtest pipe-B: SUCCESS (0.001s)
[87.688296] Starting dynamic subtest: pipe-C
[87.689721] Dynamic subtest pipe-C: SUCCESS (0.001s)
[87.698506] Starting dynamic subtest: pipe-D
[87.700948] Dynamic subtest pipe-D: SUCCESS (0.001s)
[87.702412] Subtest invalid-degamma-lut-sizes: SUCCESS (0.043s)
[87.834814] [011/133] (940s left) gem_softpin (allocator-basic)
[87.885162] Starting subtest: allocator-basic
[88.147508] Subtest allocator-basic: SUCCESS (0.259s)
[88.357384] [012/133] (940s left) kms_psr2_sf (psr2-overlay-plane-update-sf-dmg-area)
[89.845131] Subtest psr2-overlay-plane-update-sf-dmg-area: SKIP (0.000s)
[89.915197] [013/133] (938s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-0)
[91.423740] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-0
[92.567198] Subtest y-tiled-max-hw-stride-64bpp-rotate-0: SUCCESS (1.140s)
[92.757049] [014/133] (935s left) kms_psr (pr-primary-render)
[94.243847] Subtest pr-primary-render: SKIP (0.000s)
[94.318807] [015/133] (934s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-pwrite)
[95.809710] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-pwrite
[95.812627] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[96.059413] [016/133] (932s left) kms_psr2_sf (pr-cursor-plane-move-continuous-exceed-sf)
[97.547993] Subtest pr-cursor-plane-move-continuous-exceed-sf: SKIP (0.000s)
[97.617137] [017/133] (931s left) gem_ccs (ctrl-surf-copy)
[97.669323] Starting subtest: ctrl-surf-copy
[97.672101] Subtest ctrl-surf-copy: SKIP (0.000s)
[97.847378] [018/133] (931s left) perf (invalid-oa-metric-set-id)
[98.022313] Starting subtest: invalid-oa-metric-set-id
[98.043105] Subtest invalid-oa-metric-set-id: SUCCESS (0.020s)
[98.104079] [019/133] (930s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-pwrite)
[99.594539] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-pwrite
[99.597218] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[99.819171] [020/133] (929s left) gem_pxp (create-regular-buffer)
[102.387242] Starting subtest: create-regular-buffer
[102.390477] Subtest create-regular-buffer: SKIP (0.000s)
[102.525278] [021/133] (926s left) gem_eio (in-flight-contexts-10ms)
[102.660716] Starting subtest: in-flight-contexts-10ms
[115.896707] Subtest in-flight-contexts-10ms: SUCCESS (13.236s)
[117.529785] [022/133] (911s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-render)
[119.022646] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-render
[119.025522] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-render: SKIP (0.000s)
[119.225280] [023/133] (910s left) gem_exec_schedule (u-fairslice-all)
[119.286322] Starting subtest: u-fairslice-all
[121.364333] Subtest u-fairslice-all: SUCCESS (2.078s)
[121.848703] [024/133] (907s left) core_getstats (basic)
[121.893214] Starting subtest: basic
[121.895048] Subtest basic: SUCCESS (0.000s)
[122.047818] [025/133] (907s left) kms_ccs (crc-primary-rotation-180-4-tiled-mtl-rc-ccs)
[123.530235] Starting subtest: crc-primary-rotation-180-4-tiled-mtl-rc-ccs
[123.531833] Starting dynamic subtest: pipe-A-HDMI-A-4
[123.549794] Dynamic subtest pipe-A-HDMI-A-4: SKIP (0.001s)
[123.559707] Starting dynamic subtest: pipe-B-HDMI-A-4
[123.575294] Dynamic subtest pipe-B-HDMI-A-4: SKIP (0.001s)
[123.584742] Starting dynamic subtest: pipe-C-HDMI-A-4
[123.601173] Dynamic subtest pipe-C-HDMI-A-4: SKIP (0.001s)
[123.610776] Starting dynamic subtest: pipe-D-HDMI-A-4
[123.627807] Dynamic subtest pipe-D-HDMI-A-4: SKIP (0.001s)
[123.631141] Subtest crc-primary-rotation-180-4-tiled-mtl-rc-ccs: SKIP (0.009s)
[123.815418] [026/133] (905s left) kms_ccs (bad-pixel-format-4-tiled-dg2-mc-ccs)
[125.298658] Starting subtest: bad-pixel-format-4-tiled-dg2-mc-ccs
[125.299918] Starting dynamic subtest: pipe-A-HDMI-A-4
[125.312777] Dynamic subtest pipe-A-HDMI-A-4: SKIP (0.000s)
[125.322189] Starting dynamic subtest: pipe-B-HDMI-A-4
[125.335406] Dynamic subtest pipe-B-HDMI-A-4: SKIP (0.000s)
[125.344943] Starting dynamic subtest: pipe-C-HDMI-A-4
[125.358575] Dynamic subtest pipe-C-HDMI-A-4: SKIP (0.000s)
[125.367814] Starting dynamic subtest: pipe-D-HDMI-A-4
[125.381953] Dynamic subtest pipe-D-HDMI-A-4: SKIP (0.000s)
[125.384812] Subtest bad-pixel-format-4-tiled-dg2-mc-ccs: SKIP (0.006s)
[125.577606] [027/133] (904s left) sw_sync (alloc_fence)
[125.622921] Starting subtest: alloc_fence
[125.624768] Subtest alloc_fence: SUCCESS (0.000s)
[125.784555] [028/133] (903s left) i915_pm_rps (basic-api)
[125.836619] Starting subtest: basic-api
[125.840236] Subtest basic-api: SKIP (0.000s)
[125.994176] [029/133] (903s left) kms_cursor_legacy (cursorb-vs-flipa-toggle)
[127.478740] Starting subtest: cursorB-vs-flipA-toggle
[127.481859] Subtest cursorB-vs-flipA-toggle: SKIP (0.003s)
[127.678440] [030/133] (902s left) kms_cursor_crc (cursor-rapid-movement-128x42)
[129.351357] Starting subtest: cursor-rapid-movement-128x42
[129.358984] Starting dynamic subtest: pipe-A-HDMI-A-4
[129.795524] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (0.438s)
[129.825144] Starting dynamic subtest: pipe-D-HDMI-A-4
[130.134803] Dynamic subtest pipe-D-HDMI-A-4: SUCCESS (0.318s)
[130.136486] Subtest cursor-rapid-movement-128x42: SUCCESS (0.783s)
[130.573728] [031/133] (899s left) kms_dp_link_training (non-uhbr-sst)
[132.058613] Starting subtest: non-uhbr-sst
[132.065311] Subtest non-uhbr-sst: SKIP (0.000s)
[132.268897] [032/133] (897s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-mmap-cpu)
[133.762838] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-mmap-cpu
[133.766256] Subtest psr-2p-scndscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[134.008069] [033/133] (896s left) gem_exec_parallel (engines)
[134.063100] Starting subtest: engines
[134.064412] Starting dynamic subtest: basic
[135.637747] Dynamic subtest basic: SUCCESS (1.575s)
[135.647718] Starting dynamic subtest: contexts
[139.981238] Dynamic subtest contexts: SUCCESS (4.339s)
[139.990796] Starting dynamic subtest: fds
[144.688877] Dynamic subtest fds: SUCCESS (4.707s)
[144.698860] Starting dynamic subtest: userptr
[146.218976] Dynamic subtest userptr: SUCCESS (1.533s)
[146.220608] Subtest engines: SUCCESS (12.156s)
[146.585396] [034/133] (883s left) gem_eio (in-flight-immediate)
[146.787045] Starting subtest: in-flight-immediate
[151.369504] Subtest in-flight-immediate: SUCCESS (4.583s)
[153.041026] [FACT gem_eio (in-flight-immediate)] new: kernel.kmod_is_loaded.vgem: true
[153.046768] [035/133] (877s left) prime_mmap (test_forked)
[153.093962] Starting subtest: test_forked
[153.095461] Starting dynamic subtest: test_forked-smem
[153.166162] Dynamic subtest test_forked-smem: SUCCESS (0.072s)
[153.176315] Starting dynamic subtest: test_forked-lmem0
[153.236836] Dynamic subtest test_forked-lmem0: SUCCESS (0.070s)
[153.238414] Subtest test_forked: SUCCESS (0.143s)
[153.427441] [036/133] (877s left) kms_dsc (dsc-with-formats)
[154.910134] Starting subtest: dsc-with-formats
[154.937731] Subtest dsc-with-formats: SKIP (0.002s)
[155.117086] [037/133] (875s left) prime_busy (hang)
[155.169250] Starting subtest: hang
[155.170951] Starting dynamic subtest: rcs0
[181.431613] Dynamic subtest rcs0: SUCCESS (26.262s)
[181.441981] Starting dynamic subtest: bcs0
[188.578164] Dynamic subtest bcs0: SUCCESS (7.148s)
[188.588996] Starting dynamic subtest: vcs0
[195.556783] Dynamic subtest vcs0: SUCCESS (6.976s)
[195.567228] Starting dynamic subtest: vcs1
[202.594524] Dynamic subtest vcs1: SUCCESS (7.039s)
[202.605152] Starting dynamic subtest: vecs0
[209.571142] Dynamic subtest vecs0: SUCCESS (6.974s)
[209.573047] Subtest hang: SUCCESS (54.402s)
[209.739840] [038/133] (821s left) kms_vblank (wait-idle)
[211.225628] Starting subtest: wait-idle
[211.227175] Starting dynamic subtest: pipe-A-HDMI-A-4
[213.563986] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (2.339s)
[213.577530] Starting dynamic subtest: pipe-D-HDMI-A-4
[215.737043] Dynamic subtest pipe-D-HDMI-A-4: SUCCESS (2.168s)
[215.738503] Subtest wait-idle: SUCCESS (4.513s)
[215.944239] [039/133] (814s left) kms_pm_rpm (package-g7)
[220.056752] Starting subtest: package-g7
[220.061992] Subtest package-g7: SKIP (0.000s)
[221.052763] [040/133] (809s left) kms_cursor_legacy (flip-vs-cursor-varying-size)
[222.546384] Starting subtest: flip-vs-cursor-varying-size
[236.951761] Subtest flip-vs-cursor-varying-size: SUCCESS (14.405s)
[237.183338] [041/133] (793s left) kms_frontbuffer_tracking (psr-1p-primscrn-shrfb-msflip-blt)
[238.676911] Starting subtest: psr-1p-primscrn-shrfb-msflip-blt
[238.680397] Subtest psr-1p-primscrn-shrfb-msflip-blt: SKIP (0.000s)
[238.910519] [042/133] (792s left) syncobj_timeline (single-wait-all-for-submit-signaled)
[238.967893] Starting subtest: single-wait-all-for-submit-signaled
[238.969753] Subtest single-wait-all-for-submit-signaled: SUCCESS (0.001s)
[239.105342] [043/133] (792s left) perf (gen12-group-exclusive-stream-ctx-handle)
[239.276152] Starting subtest: gen12-group-exclusive-stream-ctx-handle
[239.302310] Subtest gen12-group-exclusive-stream-ctx-handle: SUCCESS (0.025s)
[239.378916] [044/133] (791s left) gem_wait (busy)
[239.440033] Starting subtest: busy
[239.441659] Starting dynamic subtest: all-engines
[240.033680] Dynamic subtest all-engines: SUCCESS (0.593s)
[240.044709] Starting dynamic subtest: rcs0
[240.572441] Dynamic subtest rcs0: SUCCESS (0.538s)
[240.582696] Starting dynamic subtest: bcs0
[241.110621] Dynamic subtest bcs0: SUCCESS (0.538s)
[241.121115] Starting dynamic subtest: vcs0
[241.648499] Dynamic subtest vcs0: SUCCESS (0.537s)
[241.658861] Starting dynamic subtest: vcs1
[242.186461] Dynamic subtest vcs1: SUCCESS (0.537s)
[242.196789] Starting dynamic subtest: vecs0
[242.724439] Dynamic subtest vecs0: SUCCESS (0.537s)
[242.726053] Subtest busy: SUCCESS (3.285s)
[243.065298] [045/133] (788s left) gen9_exec_parse (bb-secure)
[243.117752] Subtest bb-secure: SKIP (0.000s)
[243.193012] [046/133] (788s left) kms_cursor_edge_walk (128x128-right-edge)
[244.677557] Starting subtest: 128x128-right-edge
[244.679128] Starting dynamic subtest: pipe-A-HDMI-A-4
[247.996397] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (3.318s)
[248.006718] Starting dynamic subtest: pipe-D-HDMI-A-4
[251.206492] Dynamic subtest pipe-D-HDMI-A-4: SUCCESS (3.209s)
[251.208115] Subtest 128x128-right-edge: SUCCESS (6.531s)
[251.419316] [047/133] (780s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-mmap-gtt)
[252.909021] Starting subtest: psr-2p-primscrn-pri-indfb-draw-mmap-gtt
[252.912195] Subtest psr-2p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[253.140972] [048/133] (778s left) prime_mmap (test_forked_cpu_write)
[253.187709] Starting subtest: test_forked_cpu_write
[253.189237] Starting dynamic subtest: test_forked_cpu_write-smem
[253.197727] Dynamic subtest test_forked_cpu_write-smem: SUCCESS (0.011s)
[253.208131] Starting dynamic subtest: test_forked_cpu_write-lmem0
[253.209807] Dynamic subtest test_forked_cpu_write-lmem0: SUCCESS (0.011s)
[253.211421] Subtest test_forked_cpu_write: SUCCESS (0.023s)
[253.425792] [049/133] (778s left) kms_addfb_basic (small-bo)
[254.909437] Starting subtest: small-bo
[254.910921] Subtest small-bo: SUCCESS (0.000s)
[255.164617] [050/133] (776s left) kms_chamelium_audio (dp-audio)
[256.725484] Subtest dp-audio: SKIP (0.000s)
[256.833321] [051/133] (775s left) kms_chamelium_edid (hdmi-edid-change-during-suspend)
[258.394315] Subtest hdmi-edid-change-during-suspend: SKIP (0.000s)
[258.504727] [052/133] (773s left) kms_frontbuffer_tracking (psr-shrfb-scaledprimary)
[259.995364] Starting subtest: psr-shrfb-scaledprimary
[259.998154] Subtest psr-shrfb-scaledprimary: SKIP (0.000s)
[260.244570] [053/133] (772s left) kms_flip_scaled_crc (flip-32bpp-yftile-to-32bpp-yftileccs-downscaling)
[261.728790] Starting subtest: flip-32bpp-yftile-to-32bpp-yftileccs-downscaling
[261.731886] Subtest flip-32bpp-yftile-to-32bpp-yftileccs-downscaling: SKIP (0.000s)
[261.942130] [054/133] (770s left) perf (i915-ref-count)
[262.109811] Starting subtest: i915-ref-count
[262.142157] Subtest i915-ref-count: SUCCESS (0.031s)
[262.221941] [055/133] (770s left) kms_joiner (invalid-modeset-force-big-joiner)
[263.710546] Starting subtest: invalid-modeset-force-big-joiner
[263.713511] Subtest invalid-modeset-force-big-joiner: SKIP (0.000s)
[263.918834] [056/133] (768s left) kms_cursor_crc (cursor-alpha-opaque)
[265.401510] Starting subtest: cursor-alpha-opaque
[265.403127] Starting dynamic subtest: pipe-A-HDMI-A-4
[266.014412] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (0.610s)
[266.025729] Starting dynamic subtest: pipe-D-HDMI-A-4
[266.435972] Dynamic subtest pipe-D-HDMI-A-4: SUCCESS (0.420s)
[266.437294] Subtest cursor-alpha-opaque: SUCCESS (1.034s)
[267.150325] [057/133] (765s left) kms_legacy_colorkey (basic)
[268.636732] Starting subtest: basic
[268.638230] Starting dynamic subtest: pipe-A
[268.735622] Dynamic subtest pipe-A: SUCCESS (0.100s)
[268.755151] Starting dynamic subtest: pipe-B
[268.757073] Dynamic subtest pipe-B: SUCCESS (0.001s)
[268.790391] Starting dynamic subtest: pipe-C
[268.792915] Dynamic subtest pipe-C: SUCCESS (0.001s)
[268.837169] Starting dynamic subtest: pipe-D
[268.839742] Dynamic subtest pipe-D: SUCCESS (0.001s)
[268.842313] Subtest basic: SUCCESS (0.109s)
[268.945893] [058/133] (763s left) kms_big_fb (linear-max-hw-stride-64bpp-rotate-180-hflip)
[270.447995] Starting subtest: linear-max-hw-stride-64bpp-rotate-180-hflip
[270.450925] Subtest linear-max-hw-stride-64bpp-rotate-180-hflip: SKIP (0.000s)
[270.669409] [059/133] (762s left) kms_addfb_basic (bad-pitch-32)
[270.715629] Starting subtest: bad-pitch-32
[270.717167] Subtest bad-pitch-32: SUCCESS (0.000s)
[272.400602] [060/133] (760s left) gem_render_copy (x-tiled-to-vebox-y-tiled)
[272.453359] Starting subtest: x-tiled-to-vebox-y-tiled
[272.454906] Starting dynamic subtest: smem
[272.537513] Dynamic subtest smem: SUCCESS (0.084s)
[272.548047] Starting dynamic subtest: lmem0
[273.299811] Dynamic subtest lmem0: SUCCESS (0.758s)
[273.301644] Subtest x-tiled-to-vebox-y-tiled: SUCCESS (0.843s)
[273.604832] [061/133] (759s left) gem_exec_reloc (basic-range)
[273.656806] Subtest basic-range: SKIP (0.000s)
[273.773623] [062/133] (759s left) kms_big_fb (yf-tiled-64bpp-rotate-0)
[275.275300] Starting subtest: yf-tiled-64bpp-rotate-0
[275.278332] Subtest yf-tiled-64bpp-rotate-0: SKIP (0.000s)
[275.513194] [063/133] (757s left) syncobj_wait (wait-all-for-submit-snapshot)
[275.561946] Starting subtest: wait-all-for-submit-snapshot
[275.643206] Subtest wait-all-for-submit-snapshot: SUCCESS (0.082s)
[275.857955] [064/133] (757s left) kms_async_flips (invalid-async-flip)
[277.341770] Starting subtest: invalid-async-flip
[277.594535] Starting dynamic subtest: pipe-A-HDMI-A-4
[278.020437] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (0.426s)
[278.200427] Starting dynamic subtest: pipe-B-HDMI-A-4
[278.287409] Dynamic subtest pipe-B-HDMI-A-4: SUCCESS (0.096s)
[278.461704] Starting dynamic subtest: pipe-C-HDMI-A-4
[278.561400] Dynamic subtest pipe-C-HDMI-A-4: SUCCESS (0.108s)
[278.716257] Starting dynamic subtest: pipe-D-HDMI-A-4
[278.812781] Dynamic subtest pipe-D-HDMI-A-4: SUCCESS (0.106s)
[278.814168] Subtest invalid-async-flip: SUCCESS (1.473s)
[279.212999] [065/133] (754s left) kms_flip (single-buffer-flip-vs-dpms-off-vs-modeset-interruptible)
[280.702762] Starting subtest: single-buffer-flip-vs-dpms-off-vs-modeset-interruptible
[280.713599] Starting dynamic subtest: A-HDMI-A4
[281.380714] Dynamic subtest A-HDMI-A4: SUCCESS (0.669s)
[281.391209] Starting dynamic subtest: B-HDMI-A4
[282.040822] Dynamic subtest B-HDMI-A4: SUCCESS (0.659s)
[282.051449] Starting dynamic subtest: C-HDMI-A4
[282.717492] Dynamic subtest C-HDMI-A4: SUCCESS (0.675s)
[282.728186] Starting dynamic subtest: D-HDMI-A4
[283.395216] Dynamic subtest D-HDMI-A4: SUCCESS (0.677s)
[283.396811] Subtest single-buffer-flip-vs-dpms-off-vs-modeset-interruptible: SUCCESS (2.692s)
[283.615187] [066/133] (750s left) kms_frontbuffer_tracking (fbc-suspend)
[285.115164] Starting subtest: fbc-suspend
[331.205719] Subtest fbc-suspend: SUCCESS (22.576s)
[334.499459] [067/133] (702s left) syncobj_timeline (invalid-transfer-bad-pad)
[334.552328] Starting subtest: invalid-transfer-bad-pad
[334.553979] Subtest invalid-transfer-bad-pad: SUCCESS (0.000s)
[334.692649] [068/133] (702s left) kms_big_fb (4-tiled-64bpp-rotate-90)
[336.196527] Starting subtest: 4-tiled-64bpp-rotate-90
[336.202326] Subtest 4-tiled-64bpp-rotate-90: SKIP (0.000s)
[336.390565] [069/133] (700s left) gem_ctx_persistence (saturated-hostile-nopreempt)
[336.446826] Starting subtest: saturated-hostile-nopreempt
[336.448541] Starting dynamic subtest: rcs0
[337.229831] Dynamic subtest rcs0: SUCCESS (0.782s)
[337.245940] Starting dynamic subtest: bcs0
[338.004014] Dynamic subtest bcs0: SUCCESS (0.773s)
[338.018889] Starting dynamic subtest: vcs0
[338.801437] Dynamic subtest vcs0: SUCCESS (0.794s)
[338.815561] Starting dynamic subtest: vcs1
[339.588541] Dynamic subtest vcs1: SUCCESS (0.784s)
[339.602380] Starting dynamic subtest: vecs0
[340.370491] Dynamic subtest vecs0: SUCCESS (0.779s)
[340.374082] Subtest saturated-hostile-nopreempt: SUCCESS (3.926s)
[340.563669] [070/133] (696s left) gem_exec_big (single)
[340.616803] Starting subtest: single
[347.885028] Subtest single: SUCCESS (7.269s)
[348.778325] [071/133] (688s left) gem_exec_fence (submit67)
[348.996728] Starting subtest: submit67
[348.999688] Subtest submit67: SKIP (0.000s)
[349.602168] [072/133] (687s left) kms_frontbuffer_tracking (psr-2p-scndscrn-shrfb-pgflip-blt)
[351.102552] Starting subtest: psr-2p-scndscrn-shrfb-pgflip-blt
[351.105568] Subtest psr-2p-scndscrn-shrfb-pgflip-blt: SKIP (0.000s)
[351.287245] [073/133] (685s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-mmap-wc)
[352.779370] Starting subtest: fbc-rgb101010-draw-mmap-wc
[352.782775] Subtest fbc-rgb101010-draw-mmap-wc: SKIP (0.000s)
[352.999244] [074/133] (684s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-mmap-gtt)
[354.492212] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-mmap-gtt
[354.495375] Subtest fbc-1p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[354.740717] [075/133] (682s left) i915_drm_fdinfo (busy-idle)
[354.793024] Starting subtest: busy-idle
[354.794520] Starting dynamic subtest: rcs0
[354.797863] Dynamic subtest rcs0: SKIP (0.001s)
[354.810585] Starting dynamic subtest: bcs0
[354.813633] Dynamic subtest bcs0: SKIP (0.000s)
[354.827292] Starting dynamic subtest: vcs0
[354.830404] Dynamic subtest vcs0: SKIP (0.000s)
[354.843278] Starting dynamic subtest: vcs1
[354.846371] Dynamic subtest vcs1: SKIP (0.013s)
[354.859441] Starting dynamic subtest: vecs0
[354.863063] Dynamic subtest vecs0: SKIP (0.000s)
[354.866543] Subtest busy-idle: SKIP (0.022s)
[354.937991] [076/133] (682s left) kms_psr (psr2-primary-page-flip)
[356.455948] Subtest psr2-primary-page-flip: SKIP (0.000s)
[356.533816] [077/133] (681s left) kms_cursor_legacy (cursora-vs-flipb-atomic)
[358.018042] Starting subtest: cursorA-vs-flipB-atomic
[358.023375] Subtest cursorA-vs-flipB-atomic: SKIP (0.002s)
[358.233627] [078/133] (679s left) kms_prop_blob (blob-prop-lifetime)
[358.280030] Starting subtest: blob-prop-lifetime
[358.281497] Subtest blob-prop-lifetime: SUCCESS (0.001s)
[358.472440] [079/133] (679s left) kms_plane_scaling (plane-scaler-with-clipping-clamping-pixel-formats)
[359.955928] Starting subtest: plane-scaler-with-clipping-clamping-pixel-formats
[359.957290] Starting dynamic subtest: pipe-A
[362.522051] Dynamic subtest pipe-A: SUCCESS (2.565s)
[362.545916] Starting dynamic subtest: pipe-B
[365.111567] Dynamic subtest pipe-B: SUCCESS (2.587s)
[365.132331] Starting dynamic subtest: pipe-C
[365.401544] Dynamic subtest pipe-C: SUCCESS (0.288s)
[365.422711] Starting dynamic subtest: pipe-D
[365.692721] Dynamic subtest pipe-D: SUCCESS (0.289s)
[365.694389] Subtest plane-scaler-with-clipping-clamping-pixel-formats: SUCCESS (5.738s)
[365.989106] [080/133] (672s left) kms_pipe_crc_basic (hang-read-crc)
[367.480629] Starting subtest: hang-read-crc
[367.482220] Starting dynamic subtest: pipe-A-HDMI-A-4
[368.958037] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (1.476s)
[368.973234] Starting dynamic subtest: pipe-B-HDMI-A-4
[370.189469] Dynamic subtest pipe-B-HDMI-A-4: SUCCESS (1.228s)
[370.206657] Starting dynamic subtest: pipe-C-HDMI-A-4
[371.403098] Dynamic subtest pipe-C-HDMI-A-4: SUCCESS (1.210s)
[371.418601] Starting dynamic subtest: pipe-D-HDMI-A-4
[372.636991] Dynamic subtest pipe-D-HDMI-A-4: SUCCESS (1.230s)
[372.638610] Subtest hang-read-crc: SUCCESS (5.156s)
[372.867773] [081/133] (665s left) kms_selftest (drm_format)
[372.933743] Starting subtest: drm_format
[373.008779] Starting dynamic subtest: drm_test_format_block_width_invalid
[373.041305] Dynamic subtest drm_test_format_block_width_invalid: SUCCESS (0.095s)
[373.057573] Starting dynamic subtest: drm_test_format_block_width_one_plane
[373.133062] Dynamic subtest drm_test_format_block_width_one_plane: SUCCESS (0.084s)
[373.181115] Starting dynamic subtest: drm_test_format_block_width_two_plane
[373.222377] Dynamic subtest drm_test_format_block_width_two_plane: SUCCESS (0.084s)
[373.244730] Starting dynamic subtest: drm_test_format_block_width_three_plane
[373.302874] Dynamic subtest drm_test_format_block_width_three_plane: SUCCESS (0.076s)
[373.351391] Starting dynamic subtest: drm_test_format_block_width_tiled
[373.387223] Dynamic subtest drm_test_format_block_width_tiled: SUCCESS (0.077s)
[373.407042] Starting dynamic subtest: drm_test_format_block_height_invalid
[373.457918] Dynamic subtest drm_test_format_block_height_invalid: SUCCESS (0.068s)
[373.501084] Starting dynamic subtest: drm_test_format_block_height_one_plane
[373.534241] Dynamic subtest drm_test_format_block_height_one_plane: SUCCESS (0.071s)
[373.554130] Starting dynamic subtest: drm_test_format_block_height_two_plane
[373.606045] Dynamic subtest drm_test_format_block_height_two_plane: SUCCESS (0.070s)
[373.619855] Starting dynamic subtest: drm_test_format_block_height_three_plane
[373.684014] Dynamic subtest drm_test_format_block_height_three_plane: SUCCESS (0.074s)
[373.732020] Starting dynamic subtest: drm_test_format_block_height_tiled
[373.773377] Dynamic subtest drm_test_format_block_height_tiled: SUCCESS (0.084s)
[373.796289] Starting dynamic subtest: drm_test_format_min_pitch_invalid
[373.855732] Dynamic subtest drm_test_format_min_pitch_invalid: SUCCESS (0.078s)
[373.872276] Starting dynamic subtest: drm_test_format_min_pitch_one_plane_8bpp
[373.935154] Dynamic subtest drm_test_format_min_pitch_one_plane_8bpp: SUCCESS (0.073s)
[373.979717] Starting dynamic subtest: drm_test_format_min_pitch_one_plane_16bpp
[374.024756] Dynamic subtest drm_test_format_min_pitch_one_plane_16bpp: SUCCESS (0.086s)
[374.065492] Starting dynamic subtest: drm_test_format_min_pitch_one_plane_24bpp
[374.108294] Dynamic subtest drm_test_format_min_pitch_one_plane_24bpp: SUCCESS (0.080s)
[374.135619] Starting dynamic subtest: drm_test_format_min_pitch_one_plane_32bpp
[374.182369] Dynamic subtest drm_test_format_min_pitch_one_plane_32bpp: SUCCESS (0.070s)
[374.229683] Starting dynamic subtest: drm_test_format_min_pitch_two_plane
[374.269911] Dynamic subtest drm_test_format_min_pitch_two_plane: SUCCESS (0.084s)
[374.295964] Starting dynamic subtest: drm_test_format_min_pitch_three_plane_8bpp
[374.360635] Dynamic subtest drm_test_format_min_pitch_three_plane_8bpp: SUCCESS (0.086s)
[374.377935] Starting dynamic subtest: drm_test_format_min_pitch_tiled
[374.434778] Dynamic subtest drm_test_format_min_pitch_tiled: SUCCESS (0.069s)
[374.436790] Subtest drm_format: SUCCESS (1.500s)
[374.726667] [082/133] (663s left) gem_close_race (multigpu-basic-process)
[374.799505] Starting subtest: multigpu-basic-process
[374.803183] Subtest multigpu-basic-process: SKIP (0.000s)
[375.074697] [083/133] (663s left) gem_set_tiling_vs_gtt
[375.197670] [084/133] (663s left) kms_plane_scaling (planes-downscale-factor-0-5-unity-scaling)
[376.679137] Starting subtest: planes-downscale-factor-0-5-unity-scaling
[376.680652] Starting dynamic subtest: pipe-A
[376.841921] Dynamic subtest pipe-A: SUCCESS (0.162s)
[376.864489] Starting dynamic subtest: pipe-B
[377.002497] Dynamic subtest pipe-B: SUCCESS (0.159s)
[377.015636] Starting dynamic subtest: pipe-C
[377.142440] Dynamic subtest pipe-C: SUCCESS (0.138s)
[377.155228] Starting dynamic subtest: pipe-D
[377.283406] Dynamic subtest pipe-D: SUCCESS (0.139s)
[377.285007] Subtest planes-downscale-factor-0-5-unity-scaling: SUCCESS (0.605s)
[377.478395] [085/133] (660s left) kms_addfb_basic (basic-y-tiled-legacy)
[377.527620] Starting subtest: basic-y-tiled-legacy
[377.530938] Subtest basic-y-tiled-legacy: SKIP (0.000s)
[379.219636] [086/133] (659s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-0)
[380.728869] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-0
[381.990937] Subtest x-tiled-max-hw-stride-32bpp-rotate-0: SUCCESS (1.261s)
[382.266203] [087/133] (656s left) gem_render_copy (y-tiled-mc-ccs-to-yf-tiled-ccs)
[382.319526] Starting subtest: y-tiled-mc-ccs-to-yf-tiled-ccs
[382.321221] Starting dynamic subtest: smem
[382.417598] Dynamic subtest smem: SUCCESS (0.097s)
[382.430580] Starting dynamic subtest: lmem0
[383.532213] Dynamic subtest lmem0: SUCCESS (1.112s)
[383.533902] Subtest y-tiled-mc-ccs-to-yf-tiled-ccs: SUCCESS (1.213s)
[383.855413] [088/133] (654s left) gem_caching (writes)
[383.906618] Starting subtest: writes
[388.815565] Subtest writes: SUCCESS (4.909s)
[389.045420] [089/133] (649s left) syncobj_timeline (etime-multi-wait-for-submit-unsubmitted)
[389.093245] Starting subtest: etime-multi-wait-for-submit-unsubmitted
[389.197519] Subtest etime-multi-wait-for-submit-unsubmitted: SUCCESS (0.102s)
[389.403872] [090/133] (649s left) kms_flip (wf_vblank-ts-check)
[390.895449] Starting subtest: wf_vblank-ts-check
[390.902530] Starting dynamic subtest: A-HDMI-A4
[398.920436] Dynamic subtest A-HDMI-A4: SUCCESS (8.018s)
[398.936548] Starting dynamic subtest: B-HDMI-A4
[406.880869] Dynamic subtest B-HDMI-A4: SUCCESS (7.958s)
[406.897049] Starting dynamic subtest: C-HDMI-A4
[414.842077] Dynamic subtest C-HDMI-A4: SUCCESS (7.959s)
[414.858092] Starting dynamic subtest: D-HDMI-A4
[422.802691] Dynamic subtest D-HDMI-A4: SUCCESS (7.959s)
[422.803970] Subtest wf_vblank-ts-check: SUCCESS (31.909s)
[423.077434] [091/133] (615s left) gem_lmem_evict (dontneed-evict-race)
[427.535132] Starting subtest: dontneed-evict-race
[429.614676] Subtest dontneed-evict-race: SUCCESS (2.079s)
[431.505750] [FACT gem_lmem_evict (dontneed-evict-race)] deleted: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[431.506889] [FACT gem_lmem_evict (dontneed-evict-race)] deleted: kernel.kmod_is_loaded.i915: true
[431.510147] [092/133] (607s left) gem_mmap_gtt (medium-copy-odd)
[434.751215] Subtest medium-copy-odd: SKIP (0.000s)
[434.826202] [FACT gem_mmap_gtt (medium-copy-odd)] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[434.829628] [FACT gem_mmap_gtt (medium-copy-odd)] new: kernel.kmod_is_loaded.i915: true
[434.833654] [093/133] (604s left) kms_plane (pixel-format-4-tiled-dg2-mc-ccs-modifier)
[436.321438] Starting subtest: pixel-format-4-tiled-dg2-mc-ccs-modifier
[436.331028] Subtest pixel-format-4-tiled-dg2-mc-ccs-modifier: SKIP (0.000s)
[436.466024] [094/133] (602s left) kms_ccs (crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc)
[437.966001] Starting subtest: crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc
[437.967469] Starting dynamic subtest: pipe-A-HDMI-A-4
[438.007613] Dynamic subtest pipe-A-HDMI-A-4: SKIP (0.003s)
[438.019306] Starting dynamic subtest: pipe-B-HDMI-A-4
[438.063379] Dynamic subtest pipe-B-HDMI-A-4: SKIP (0.003s)
[438.074646] Starting dynamic subtest: pipe-C-HDMI-A-4
[438.119733] Dynamic subtest pipe-C-HDMI-A-4: SKIP (0.003s)
[438.130509] Starting dynamic subtest: pipe-D-HDMI-A-4
[438.170134] Dynamic subtest pipe-D-HDMI-A-4: SKIP (0.003s)
[438.173200] Subtest crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc: SKIP (0.021s)
[438.267269] [095/133] (601s left) gem_exec_suspend (basic-s0)
[438.328531] Starting subtest: basic-S0
[438.330025] Starting dynamic subtest: smem
[457.947092] Dynamic subtest smem: SUCCESS (5.292s)
[457.959273] Starting dynamic subtest: lmem0
[477.948129] Dynamic subtest lmem0: SUCCESS (4.866s)
[477.950072] Subtest basic-S0: SUCCESS (10.161s)
[484.289919] [096/133] (561s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-180)
[485.831928] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-180
[485.835429] Subtest 4-tiled-max-hw-stride-64bpp-rotate-180: SKIP (0.000s)
[486.066319] [097/133] (559s left) gem_mmap_offset (bad-extensions)
[486.115758] Starting subtest: bad-extensions
[486.117882] Subtest bad-extensions: SUCCESS (0.000s)
[486.340951] [098/133] (559s left) kms_cursor_legacy (2x-long-nonblocking-modeset-vs-cursor-atomic)
[487.852950] Starting subtest: 2x-long-nonblocking-modeset-vs-cursor-atomic
[487.856350] Subtest 2x-long-nonblocking-modeset-vs-cursor-atomic: SKIP (0.003s)
[488.007928] [099/133] (557s left) gem_mmap_gtt (cpuset-big-copy-odd)
[488.072302] Subtest cpuset-big-copy-odd: SKIP (0.000s)
[488.148699] [100/133] (557s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-180-async-flip)
[489.672602] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-180-async-flip
[489.676276] Subtest yf-tiled-max-hw-stride-64bpp-rotate-180-async-flip: SKIP (0.000s)
[489.849260] [101/133] (556s left) kms_psr (fbc-psr2-sprite-render)
[491.353135] Subtest fbc-psr2-sprite-render: SKIP (0.000s)
[491.439917] [102/133] (554s left) kms_frontbuffer_tracking (fbcpsr-1p-shrfb-fliptrack-mmap-gtt)
[492.946979] Starting subtest: fbcpsr-1p-shrfb-fliptrack-mmap-gtt
[492.949933] Subtest fbcpsr-1p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s)
[493.191855] [103/133] (553s left) kms_ccs (crc-primary-basic-y-tiled-ccs)
[494.688295] Starting subtest: crc-primary-basic-y-tiled-ccs
[494.689812] Starting dynamic subtest: pipe-A-HDMI-A-4
[494.704691] Dynamic subtest pipe-A-HDMI-A-4: SKIP (0.001s)
[494.716955] Starting dynamic subtest: pipe-B-HDMI-A-4
[494.732178] Dynamic subtest pipe-B-HDMI-A-4: SKIP (0.001s)
[494.743988] Starting dynamic subtest: pipe-C-HDMI-A-4
[494.759412] Dynamic subtest pipe-C-HDMI-A-4: SKIP (0.001s)
[494.771086] Starting dynamic subtest: pipe-D-HDMI-A-4
[494.788061] Dynamic subtest pipe-D-HDMI-A-4: SKIP (0.001s)
[494.791735] Subtest crc-primary-basic-y-tiled-ccs: SKIP (0.014s)
[494.968681] [104/133] (551s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-pwrite)
[496.470378] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-pwrite
[496.473530] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[496.709979] [105/133] (549s left) api_intel_bb (add-remove-objects)
[496.757840] Starting subtest: add-remove-objects
[496.777532] Subtest add-remove-objects: SUCCESS (0.022s)
[497.019834] [106/133] (549s left) sysfs_heartbeat_interval (nopreempt)
[497.075702] Starting subtest: nopreempt
[497.077346] Starting dynamic subtest: vecs0
[501.113564] Dynamic subtest vecs0: SUCCESS (4.019s)
[501.128340] Starting dynamic subtest: vcs0
[505.125985] Dynamic subtest vcs0: SUCCESS (4.000s)
[505.139196] Starting dynamic subtest: bcs0
[509.147134] Dynamic subtest bcs0: SUCCESS (4.013s)
[509.160054] Starting dynamic subtest: rcs0
[513.176222] Dynamic subtest rcs0: SUCCESS (4.022s)
[513.188954] Starting dynamic subtest: vcs1
[517.216728] Dynamic subtest vcs1: SUCCESS (4.035s)
[517.218459] Subtest nopreempt: SUCCESS (20.098s)
[517.438919] [107/133] (529s left) kms_getfb (getfb2-into-addfb2)
[518.926700] Starting subtest: getfb2-into-addfb2
[518.928241] Subtest getfb2-into-addfb2: SUCCESS (0.000s)
[519.180364] [108/133] (527s left) gem_close (basic)
[519.231636] Starting subtest: basic
[519.233263] Subtest basic: SUCCESS (0.000s)
[519.451021] [109/133] (527s left) gem_exec_schedule (preemptive-hang)
[519.623534] Starting subtest: preemptive-hang
[519.624930] Starting dynamic subtest: rcs0
[529.067337] Dynamic subtest rcs0: SUCCESS (9.444s)
[529.079977] Starting dynamic subtest: bcs0
[538.086831] Dynamic subtest bcs0: SUCCESS (9.016s)
[538.099716] Starting dynamic subtest: vcs0
[547.054873] Dynamic subtest vcs0: SUCCESS (8.965s)
[547.067840] Starting dynamic subtest: vcs1
[556.081242] Dynamic subtest vcs1: SUCCESS (9.021s)
[556.094312] Starting dynamic subtest: vecs0
[565.052998] Dynamic subtest vecs0: SUCCESS (8.968s)
[565.054726] Subtest preemptive-hang: SUCCESS (45.421s)
[565.434727] [110/133] (481s left) i915_drm_fdinfo (virtual-busy-idle)
[565.491507] Starting subtest: virtual-busy-idle
[565.494263] Subtest virtual-busy-idle: SKIP (0.000s)
[565.643001] [111/133] (481s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-mmap-wc)
[567.133386] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-mmap-wc
[567.137135] Subtest fbc-1p-offscreen-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[567.360737] [112/133] (479s left) gem_linear_blits (interruptible)
[567.611471] Starting subtest: interruptible
[576.082486] Subtest interruptible: SUCCESS (8.465s)
[576.325876] [113/133] (470s left) gem_ctx_persistence (engines-mixed)
[576.429972] Starting subtest: engines-mixed
[576.431521] Starting dynamic subtest: rcs0
[576.504935] Dynamic subtest rcs0: SUCCESS (0.074s)
[576.526270] Starting dynamic subtest: bcs0
[576.562038] Dynamic subtest bcs0: SUCCESS (0.055s)
[576.597306] Starting dynamic subtest: vcs0
[576.628985] Dynamic subtest vcs0: SUCCESS (0.064s)
[576.646385] Starting dynamic subtest: vcs1
[576.699027] Dynamic subtest vcs1: SUCCESS (0.067s)
[576.732461] Starting dynamic subtest: vecs0
[576.778924] Dynamic subtest vecs0: SUCCESS (0.076s)
[576.787846] Subtest engines-mixed: SUCCESS (0.352s)
[577.001884] [114/133] (470s left) perf_pmu (init-wait)
[577.054836] Starting subtest: init-wait
[577.056409] Starting dynamic subtest: rcs0
[577.058020] Dynamic subtest rcs0: SUCCESS (0.002s)
[577.071125] Starting dynamic subtest: bcs0
[577.072804] Dynamic subtest bcs0: SUCCESS (0.001s)
[577.085822] Starting dynamic subtest: vcs0
[577.087616] Dynamic subtest vcs0: SUCCESS (0.001s)
[577.100308] Starting dynamic subtest: vcs1
[577.102064] Dynamic subtest vcs1: SUCCESS (0.001s)
[577.114634] Starting dynamic subtest: vecs0
[577.116369] Dynamic subtest vecs0: SUCCESS (0.001s)
[577.118104] Subtest init-wait: SUCCESS (0.012s)
[577.189903] [115/133] (470s left) gem_exec_reloc (basic-gtt-cpu-active)
[577.248013] Subtest basic-gtt-cpu-active: SKIP (0.000s)
[577.356341] [116/133] (470s left) kms_pm_lpsp (screens-disabled)
[579.860667] Starting subtest: screens-disabled
[579.863844] Subtest screens-disabled: SKIP (0.000s)
[580.062843] [117/133] (467s left) kms_flip (flip-vs-expired-vblank-interruptible)
[581.552025] Starting subtest: flip-vs-expired-vblank-interruptible
[581.560559] Starting dynamic subtest: A-HDMI-A4
[589.351844] Dynamic subtest A-HDMI-A4: SUCCESS (7.793s)
[589.396376] Starting dynamic subtest: B-HDMI-A4
[597.060661] Dynamic subtest B-HDMI-A4: SUCCESS (7.700s)
[597.077928] Starting dynamic subtest: C-HDMI-A4
[604.737129] Dynamic subtest C-HDMI-A4: SUCCESS (7.672s)
[604.779746] Starting dynamic subtest: D-HDMI-A4
[612.415795] Dynamic subtest D-HDMI-A4: SUCCESS (7.669s)
[612.424917] Subtest flip-vs-expired-vblank-interruptible: SUCCESS (30.871s)
[612.681243] [118/133] (435s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-move)
[614.172553] Starting subtest: psr-1p-primscrn-cur-indfb-move
[614.175498] Subtest psr-1p-primscrn-cur-indfb-move: SKIP (0.000s)
[614.420561] [119/133] (433s left) kms_atomic_transition (plane-all-modeset-transition-internal-panels)
[615.906942] Starting subtest: plane-all-modeset-transition-internal-panels
[615.909703] Subtest plane-all-modeset-transition-internal-panels: SKIP (0.000s)
[616.109355] [120/133] (431s left) gem_userptr_blits (stress-mm)
[616.172702] Starting subtest: stress-mm
[621.544708] Subtest stress-mm: SUCCESS (5.369s)
[621.779024] [121/133] (426s left) syncobj_eventfd (invalid-bad-flags)
[621.833554] Starting subtest: invalid-bad-flags
[621.835072] Subtest invalid-bad-flags: SUCCESS (0.000s)
[622.028257] [122/133] (426s left) kms_addfb_basic (framebuffer-vs-set-tiling)
[622.075322] Starting subtest: framebuffer-vs-set-tiling
[622.078504] Subtest framebuffer-vs-set-tiling: SKIP (0.000s)
[623.783711] [123/133] (424s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-indfb-msflip-blt)
[625.275907] Starting subtest: fbc-2p-scndscrn-indfb-msflip-blt
[625.278955] Subtest fbc-2p-scndscrn-indfb-msflip-blt: SKIP (0.000s)
[625.512369] [124/133] (422s left) syncobj_timeline (multi-wait-for-submit-available-submitted-signaled)
[625.560582] Starting subtest: multi-wait-for-submit-available-submitted-signaled
[625.562042] Subtest multi-wait-for-submit-available-submitted-signaled: SUCCESS (0.001s)
[625.764818] [125/133] (422s left) kms_flip (2x-modeset-vs-vblank-race)
[627.249019] Starting subtest: 2x-modeset-vs-vblank-race
[627.266758] Subtest 2x-modeset-vs-vblank-race: SKIP (0.017s)
[627.478067] [126/133] (421s left) i915_query (query-regions-garbage-items)
[627.524212] Starting subtest: query-regions-garbage-items
[627.525739] Subtest query-regions-garbage-items: SUCCESS (0.000s)
[627.732046] [127/133] (421s left) kms_psr_stress_test (flip-primary-invalidate-overlay)
[627.778717] Subtest flip-primary-invalidate-overlay: SKIP (0.000s)
[627.875791] [128/133] (421s left) gem_exec_balancer (full-late)
[627.932329] Starting subtest: full-late
[630.311568] Subtest full-late: SUCCESS (2.378s)
[630.810714] [129/133] (418s left) gem_exec_reloc (basic-write-wc)
[630.861962] Subtest basic-write-wc: SKIP (0.000s)
[630.970707] [130/133] (418s left) kms_force_connector_basic (force-load-detect)
[631.100491] Starting subtest: force-load-detect
[631.103111] Subtest force-load-detect: SKIP (0.000s)
[632.097072] [131/133] (417s left) kms_chamelium_hpd (hdmi-hpd-fast)
[633.631664] Subtest hdmi-hpd-fast: SKIP (0.000s)
[633.745762] [132/133] (415s left) kms_flip_scaled_crc (flip-64bpp-xtile-to-32bpp-xtile-upscaling)
[635.229819] Starting subtest: flip-64bpp-xtile-to-32bpp-xtile-upscaling
[635.231250] Starting dynamic subtest: pipe-A-valid-mode
[636.079793] Dynamic subtest pipe-A-valid-mode: SUCCESS (0.848s)
[636.081236] Subtest flip-64bpp-xtile-to-32bpp-xtile-upscaling: SUCCESS (0.850s)
[636.317456] [133/133] (413s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-mmap-cpu)
[637.828285] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-mmap-cpu
[637.831058] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[638.041910] Closing watchdogs
results: parsing output: 0/ for test: kms_content_protection
results: parsing output: 1/ for test: core_getversion
results: parsing output: 2/ for test: kms_atomic_interruptible
results: parsing output: 3/ for test: kms_plane
results: parsing output: 4/ for test: kms_atomic_transition
results: parsing output: 5/ for test: kms_frontbuffer_tracking
results: parsing output: 6/ for test: kms_psr
results: parsing output: 7/ for test: perf
results: parsing output: 8/ for test: gem_eio
results: parsing output: 9/ for test: kms_color
results: parsing output: 10/ for test: gem_softpin
results: parsing output: 11/ for test: kms_psr2_sf
results: parsing output: 12/ for test: kms_big_fb
results: parsing output: 13/ for test: kms_psr
results: parsing output: 14/ for test: kms_frontbuffer_tracking
results: parsing output: 15/ for test: kms_psr2_sf
results: parsing output: 16/ for test: gem_ccs
results: parsing output: 17/ for test: perf
results: parsing output: 18/ for test: kms_frontbuffer_tracking
results: parsing output: 19/ for test: gem_pxp
results: parsing output: 20/ for test: gem_eio
results: parsing output: 21/ for test: kms_frontbuffer_tracking
results: parsing output: 22/ for test: gem_exec_schedule
results: parsing output: 23/ for test: core_getstats
results: parsing output: 24/ for test: kms_ccs
results: parsing output: 25/ for test: kms_ccs
results: parsing output: 26/ for test: sw_sync
results: parsing output: 27/ for test: i915_pm_rps
results: parsing output: 28/ for test: kms_cursor_legacy
results: parsing output: 29/ for test: kms_cursor_crc
results: parsing output: 30/ for test: kms_dp_link_training
results: parsing output: 31/ for test: kms_frontbuffer_tracking
results: parsing output: 32/ for test: gem_exec_parallel
results: parsing output: 33/ for test: gem_eio
results: parsing output: 34/ for test: prime_mmap
results: parsing output: 35/ for test: kms_dsc
results: parsing output: 36/ for test: prime_busy
results: parsing output: 37/ for test: kms_vblank
results: parsing output: 38/ for test: kms_pm_rpm
results: parsing output: 39/ for test: kms_cursor_legacy
results: parsing output: 40/ for test: kms_frontbuffer_tracking
results: parsing output: 41/ for test: syncobj_timeline
results: parsing output: 42/ for test: perf
results: parsing output: 43/ for test: gem_wait
results: parsing output: 44/ for test: gen9_exec_parse
results: parsing output: 45/ for test: kms_cursor_edge_walk
results: parsing output: 46/ for test: kms_frontbuffer_tracking
results: parsing output: 47/ for test: prime_mmap
results: parsing output: 48/ for test: kms_addfb_basic
results: parsing output: 49/ for test: kms_chamelium_audio
results: parsing output: 50/ for test: kms_chamelium_edid
results: parsing output: 51/ for test: kms_frontbuffer_tracking
results: parsing output: 52/ for test: kms_flip_scaled_crc
results: parsing output: 53/ for test: perf
results: parsing output: 54/ for test: kms_joiner
results: parsing output: 55/ for test: kms_cursor_crc
results: parsing output: 56/ for test: kms_legacy_colorkey
results: parsing output: 57/ for test: kms_big_fb
results: parsing output: 58/ for test: kms_addfb_basic
results: parsing output: 59/ for test: gem_render_copy
results: parsing output: 60/ for test: gem_exec_reloc
results: parsing output: 61/ for test: kms_big_fb
results: parsing output: 62/ for test: syncobj_wait
results: parsing output: 63/ for test: kms_async_flips
results: parsing output: 64/ for test: kms_flip
results: parsing output: 65/ for test: kms_frontbuffer_tracking
results: parsing output: 66/ for test: syncobj_timeline
results: parsing output: 67/ for test: kms_big_fb
results: parsing output: 68/ for test: gem_ctx_persistence
results: parsing output: 69/ for test: gem_exec_big
results: parsing output: 70/ for test: gem_exec_fence
results: parsing output: 71/ for test: kms_frontbuffer_tracking
results: parsing output: 72/ for test: kms_frontbuffer_tracking
results: parsing output: 73/ for test: kms_frontbuffer_tracking
results: parsing output: 74/ for test: i915_drm_fdinfo
results: parsing output: 75/ for test: kms_psr
results: parsing output: 76/ for test: kms_cursor_legacy
results: parsing output: 77/ for test: kms_prop_blob
results: parsing output: 78/ for test: kms_plane_scaling
results: parsing output: 79/ for test: kms_pipe_crc_basic
results: parsing output: 80/ for test: kms_selftest
results: parsing output: 81/ for test: gem_close_race
results: parsing output: 82/ for test: gem_set_tiling_vs_gtt
results: parsing output: 83/ for test: kms_plane_scaling
results: parsing output: 84/ for test: kms_addfb_basic
results: parsing output: 85/ for test: kms_big_fb
results: parsing output: 86/ for test: gem_render_copy
results: parsing output: 87/ for test: gem_caching
results: parsing output: 88/ for test: syncobj_timeline
results: parsing output: 89/ for test: kms_flip
results: parsing output: 90/ for test: gem_lmem_evict
results: parsing output: 91/ for test: gem_mmap_gtt
results: parsing output: 92/ for test: kms_plane
results: parsing output: 93/ for test: kms_ccs
results: parsing output: 94/ for test: gem_exec_suspend
results: parsing output: 95/ for test: kms_big_fb
results: parsing output: 96/ for test: gem_mmap_offset
results: parsing output: 97/ for test: kms_cursor_legacy
results: parsing output: 98/ for test: gem_mmap_gtt
results: parsing output: 99/ for test: kms_big_fb
results: parsing output: 100/ for test: kms_psr
results: parsing output: 101/ for test: kms_frontbuffer_tracking
results: parsing output: 102/ for test: kms_ccs
results: parsing output: 103/ for test: kms_frontbuffer_tracking
results: parsing output: 104/ for test: api_intel_bb
results: parsing output: 105/ for test: sysfs_heartbeat_interval
results: parsing output: 106/ for test: kms_getfb
results: parsing output: 107/ for test: gem_close
results: parsing output: 108/ for test: gem_exec_schedule
results: parsing output: 109/ for test: i915_drm_fdinfo
results: parsing output: 110/ for test: kms_frontbuffer_tracking
results: parsing output: 111/ for test: gem_linear_blits
results: parsing output: 112/ for test: gem_ctx_persistence
results: parsing output: 113/ for test: perf_pmu
results: parsing output: 114/ for test: gem_exec_reloc
results: parsing output: 115/ for test: kms_pm_lpsp
results: parsing output: 116/ for test: kms_flip
results: parsing output: 117/ for test: kms_frontbuffer_tracking
results: parsing output: 118/ for test: kms_atomic_transition
results: parsing output: 119/ for test: gem_userptr_blits
results: parsing output: 120/ for test: syncobj_eventfd
results: parsing output: 121/ for test: kms_addfb_basic
results: parsing output: 122/ for test: kms_frontbuffer_tracking
results: parsing output: 123/ for test: syncobj_timeline
results: parsing output: 124/ for test: kms_flip
results: parsing output: 125/ for test: i915_query
results: parsing output: 126/ for test: kms_psr_stress_test
results: parsing output: 127/ for test: gem_exec_balancer
results: parsing output: 128/ for test: gem_exec_reloc
results: parsing output: 129/ for test: kms_force_connector_basic
results: parsing output: 130/ for test: kms_chamelium_hpd
results: parsing output: 131/ for test: kms_flip_scaled_crc
results: parsing output: 132/ for test: kms_frontbuffer_tracking
Done.