[65.307578] Initializing watchdogs
[65.307657]   /dev/watchdog0
[65.337412] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:03:00.0: 8086:4905 Intel Dg1 (Gen12) DG1 [Iris Xe MAX Graphics]
[65.351907] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[65.356405] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[65.358930] [001/133] (960s left) kms_content_protection (dp-mst-lic-type-0-hdcp14)
[66.909104] Starting subtest: dp-mst-lic-type-0-hdcp14
[66.911212] Subtest dp-mst-lic-type-0-hdcp14: SKIP (0.000s)
[67.134840] [002/133] (958s left) core_getversion (all-cards)
[67.177330] Starting subtest: all-cards
[67.198331] Subtest all-cards: SUCCESS (0.020s)
[67.259913] [003/133] (958s left) kms_atomic_interruptible (legacy-dpms)
[68.741147] Starting subtest: legacy-dpms
[68.742965] Starting dynamic subtest: pipe-A-HDMI-A-1
[74.942186] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (6.200s)
[74.943026] Subtest legacy-dpms: SUCCESS (6.201s)
[75.127849] [004/133] (950s left) kms_plane (pixel-format-y-tiled-ccs-modifier-source-clamping)
[76.610140] Starting subtest: pixel-format-y-tiled-ccs-modifier-source-clamping
[76.616469] Subtest pixel-format-y-tiled-ccs-modifier-source-clamping: SKIP (0.000s)
[76.837093] [005/133] (949s left) kms_atomic_transition (plane-primary-toggle-with-vblank-wait)
[78.347324] Starting subtest: plane-primary-toggle-with-vblank-wait
[78.348225] Starting dynamic subtest: pipe-A-HDMI-A-1
[78.561367] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.213s)
[78.699445] Starting dynamic subtest: pipe-B-HDMI-A-1
[78.927338] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.237s)
[78.982489] Subtest plane-primary-toggle-with-vblank-wait: SUCCESS (0.636s)
[79.203287] [006/133] (947s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-mmap-gtt)
[80.692183] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-mmap-gtt
[80.693781] Subtest fbc-2p-scndscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[80.922749] [007/133] (945s left) kms_psr (fbc-psr2-primary-mmap-cpu)
[82.422674] Subtest fbc-psr2-primary-mmap-cpu: SKIP (0.000s)
[82.484889] [008/133] (944s left) perf (invalid-oa-exponent)
[82.658752] Starting subtest: invalid-oa-exponent
[82.684480] Subtest invalid-oa-exponent: SUCCESS (0.026s)
[82.755404] [009/133] (943s left) gem_eio (create-ext)
[82.891491] Starting subtest: create-ext
[83.071304] Subtest create-ext: SUCCESS (0.178s)
[84.727039] [010/133] (941s left) kms_color (invalid-degamma-lut-sizes)
[86.209603] Starting subtest: invalid-degamma-lut-sizes
[86.210489] Starting dynamic subtest: pipe-A
[86.256465] Dynamic subtest pipe-A: SUCCESS (0.047s)
[86.264914] Starting dynamic subtest: pipe-B
[86.265850] Dynamic subtest pipe-B: SUCCESS (0.001s)
[86.275330] Starting dynamic subtest: pipe-C
[86.276227] Dynamic subtest pipe-C: SUCCESS (0.001s)
[86.284700] Starting dynamic subtest: pipe-D
[86.285569] Dynamic subtest pipe-D: SUCCESS (0.001s)
[86.286430] Subtest invalid-degamma-lut-sizes: SUCCESS (0.049s)
[86.448507] [011/133] (940s left) gem_softpin (allocator-basic)
[86.496838] Starting subtest: allocator-basic
[86.768796] Subtest allocator-basic: SUCCESS (0.269s)
[86.952212] [012/133] (939s left) kms_psr2_sf (psr2-overlay-plane-update-sf-dmg-area)
[88.438254] Subtest psr2-overlay-plane-update-sf-dmg-area: SKIP (0.000s)
[88.509835] [013/133] (938s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-0)
[90.016745] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-0
[91.155861] Subtest y-tiled-max-hw-stride-64bpp-rotate-0: SUCCESS (1.138s)
[91.431250] [014/133] (935s left) kms_psr (pr-primary-render)
[92.914881] Subtest pr-primary-render: SKIP (0.000s)
[93.006080] [015/133] (934s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-pwrite)
[94.506203] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-pwrite
[94.507839] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[94.751604] [016/133] (932s left) kms_psr2_sf (pr-cursor-plane-move-continuous-exceed-sf)
[96.237443] Subtest pr-cursor-plane-move-continuous-exceed-sf: SKIP (0.000s)
[96.404185] [017/133] (930s left) gem_ccs (ctrl-surf-copy)
[96.453215] Starting subtest: ctrl-surf-copy
[96.455096] Subtest ctrl-surf-copy: SKIP (0.000s)
[96.617602] [018/133] (930s left) perf (invalid-oa-metric-set-id)
[96.774192] Starting subtest: invalid-oa-metric-set-id
[96.794290] Subtest invalid-oa-metric-set-id: SUCCESS (0.020s)
[96.862204] [019/133] (930s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-pwrite)
[98.349153] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-pwrite
[98.350767] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[98.611811] [020/133] (929s left) gem_pxp (create-regular-buffer)
[101.176948] Starting subtest: create-regular-buffer
[101.178705] Subtest create-regular-buffer: SKIP (0.000s)
[101.306952] [021/133] (926s left) gem_eio (in-flight-contexts-10ms)
[101.438780] Starting subtest: in-flight-contexts-10ms
[114.873219] Subtest in-flight-contexts-10ms: SUCCESS (13.434s)
[116.534379] [022/133] (911s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-render)
[118.021451] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-render
[118.023703] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-render: SKIP (0.000s)
[118.276423] [023/133] (909s left) gem_exec_schedule (u-fairslice-all)
[118.334128] Starting subtest: u-fairslice-all
[120.415148] Subtest u-fairslice-all: SUCCESS (2.081s)
[120.859332] [024/133] (907s left) core_getstats (basic)
[120.900547] Starting subtest: basic
[120.901289] Subtest basic: SUCCESS (0.000s)
[121.036887] [025/133] (907s left) kms_ccs (crc-primary-rotation-180-4-tiled-mtl-rc-ccs)
[122.519223] Starting subtest: crc-primary-rotation-180-4-tiled-mtl-rc-ccs
[122.520055] Starting dynamic subtest: pipe-A-HDMI-A-1
[122.528274] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.001s)
[122.537405] Starting dynamic subtest: pipe-B-HDMI-A-1
[122.545932] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.001s)
[122.554911] Starting dynamic subtest: pipe-C-HDMI-A-1
[122.563863] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.001s)
[122.572621] Starting dynamic subtest: pipe-D-HDMI-A-1
[122.581846] Dynamic subtest pipe-D-HDMI-A-1: SKIP (0.001s)
[122.583643] Subtest crc-primary-rotation-180-4-tiled-mtl-rc-ccs: SKIP (0.009s)
[122.789641] [026/133] (905s left) kms_ccs (bad-pixel-format-4-tiled-dg2-mc-ccs)
[124.269372] Starting subtest: bad-pixel-format-4-tiled-dg2-mc-ccs
[124.271483] Starting dynamic subtest: pipe-A-HDMI-A-1
[124.279710] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.000s)
[124.288858] Starting dynamic subtest: pipe-B-HDMI-A-1
[124.296927] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.000s)
[124.305758] Starting dynamic subtest: pipe-C-HDMI-A-1
[124.314282] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.000s)
[124.322884] Starting dynamic subtest: pipe-D-HDMI-A-1
[124.331900] Dynamic subtest pipe-D-HDMI-A-1: SKIP (0.000s)
[124.333681] Subtest bad-pixel-format-4-tiled-dg2-mc-ccs: SKIP (0.006s)
[124.508877] [027/133] (903s left) sw_sync (alloc_fence)
[124.549699] Starting subtest: alloc_fence
[124.550566] Subtest alloc_fence: SUCCESS (0.000s)
[124.717881] [028/133] (903s left) i915_pm_rps (basic-api)
[124.769429] Starting subtest: basic-api
[124.773396] Subtest basic-api: SKIP (0.000s)
[124.923144] [029/133] (903s left) kms_cursor_legacy (cursorb-vs-flipa-toggle)
[126.405145] Starting subtest: cursorB-vs-flipA-toggle
[126.407981] Subtest cursorB-vs-flipA-toggle: SKIP (0.003s)
[126.615824] [030/133] (902s left) kms_cursor_crc (cursor-rapid-movement-128x42)
[128.289589] Starting subtest: cursor-rapid-movement-128x42
[128.295788] Starting dynamic subtest: pipe-A-HDMI-A-1
[128.737047] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.441s)
[128.768109] Starting dynamic subtest: pipe-D-HDMI-A-1
[129.062251] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.302s)
[129.063165] Subtest cursor-rapid-movement-128x42: SUCCESS (0.772s)
[129.520715] [031/133] (899s left) kms_dp_link_training (non-uhbr-sst)
[131.005144] Starting subtest: non-uhbr-sst
[131.009145] Subtest non-uhbr-sst: SKIP (0.000s)
[131.227315] [032/133] (897s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-mmap-cpu)
[132.712858] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-mmap-cpu
[132.714821] Subtest psr-2p-scndscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[132.942856] [033/133] (896s left) gem_exec_parallel (engines)
[132.998151] Starting subtest: engines
[132.999062] Starting dynamic subtest: basic
[134.571913] Dynamic subtest basic: SUCCESS (1.574s)
[134.581360] Starting dynamic subtest: contexts
[139.060531] Dynamic subtest contexts: SUCCESS (4.485s)
[139.069769] Starting dynamic subtest: fds
[143.687205] Dynamic subtest fds: SUCCESS (4.626s)
[143.696598] Starting dynamic subtest: userptr
[145.236377] Dynamic subtest userptr: SUCCESS (1.552s)
[145.237460] Subtest engines: SUCCESS (12.238s)
[145.596791] [034/133] (883s left) gem_eio (in-flight-immediate)
[145.798207] Starting subtest: in-flight-immediate
[150.437819] Subtest in-flight-immediate: SUCCESS (4.641s)
[152.091922] [FACT gem_eio (in-flight-immediate)] new: kernel.kmod_is_loaded.vgem: true
[152.097289] [035/133] (877s left) prime_mmap (test_forked)
[152.140863] Starting subtest: test_forked
[152.141769] Starting dynamic subtest: test_forked-smem
[152.210800] Dynamic subtest test_forked-smem: SUCCESS (0.070s)
[152.220363] Starting dynamic subtest: test_forked-lmem0
[152.283116] Dynamic subtest test_forked-lmem0: SUCCESS (0.072s)
[152.284034] Subtest test_forked: SUCCESS (0.143s)
[152.462096] [036/133] (876s left) kms_dsc (dsc-with-formats)
[153.941847] Starting subtest: dsc-with-formats
[153.957808] Subtest dsc-with-formats: SKIP (0.002s)
[154.156819] [037/133] (875s left) prime_busy (hang)
[154.205520] Starting subtest: hang
[154.207262] Starting dynamic subtest: rcs0
[180.406386] Dynamic subtest rcs0: SUCCESS (26.201s)
[180.415829] Starting dynamic subtest: bcs0
[187.553903] Dynamic subtest bcs0: SUCCESS (7.147s)
[187.563442] Starting dynamic subtest: vcs0
[194.594451] Dynamic subtest vcs0: SUCCESS (7.040s)
[194.603985] Starting dynamic subtest: vcs1
[201.572277] Dynamic subtest vcs1: SUCCESS (6.976s)
[201.581788] Starting dynamic subtest: vecs0
[208.546258] Dynamic subtest vecs0: SUCCESS (6.974s)
[208.547394] Subtest hang: SUCCESS (54.343s)
[208.738560] [038/133] (820s left) kms_vblank (wait-idle)
[210.219899] Starting subtest: wait-idle
[210.220777] Starting dynamic subtest: pipe-A-HDMI-A-1
[212.574042] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (2.353s)
[212.586431] Starting dynamic subtest: pipe-D-HDMI-A-1
[214.745324] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (2.168s)
[214.746141] Subtest wait-idle: SUCCESS (4.527s)
[214.953731] [039/133] (814s left) kms_pm_rpm (package-g7)
[219.069501] Starting subtest: package-g7
[219.073134] Subtest package-g7: SKIP (0.000s)
[220.051885] [040/133] (809s left) kms_cursor_legacy (flip-vs-cursor-varying-size)
[221.533832] Starting subtest: flip-vs-cursor-varying-size
[235.989155] Subtest flip-vs-cursor-varying-size: SUCCESS (14.455s)
[236.195886] [041/133] (793s left) kms_frontbuffer_tracking (psr-1p-primscrn-shrfb-msflip-blt)
[237.682685] Starting subtest: psr-1p-primscrn-shrfb-msflip-blt
[237.684308] Subtest psr-1p-primscrn-shrfb-msflip-blt: SKIP (0.000s)
[237.926886] [042/133] (791s left) syncobj_timeline (single-wait-all-for-submit-signaled)
[237.971393] Starting subtest: single-wait-all-for-submit-signaled
[237.972326] Subtest single-wait-all-for-submit-signaled: SUCCESS (0.001s)
[238.120253] [043/133] (791s left) perf (gen12-group-exclusive-stream-ctx-handle)
[238.252081] Starting subtest: gen12-group-exclusive-stream-ctx-handle
[238.278325] Subtest gen12-group-exclusive-stream-ctx-handle: SUCCESS (0.026s)
[238.358526] [044/133] (791s left) gem_wait (busy)
[238.417151] Starting subtest: busy
[238.418025] Starting dynamic subtest: all-engines
[238.998192] Dynamic subtest all-engines: SUCCESS (0.581s)
[239.008234] Starting dynamic subtest: rcs0
[239.536557] Dynamic subtest rcs0: SUCCESS (0.538s)
[239.546104] Starting dynamic subtest: bcs0
[240.074674] Dynamic subtest bcs0: SUCCESS (0.538s)
[240.084276] Starting dynamic subtest: vcs0
[240.612696] Dynamic subtest vcs0: SUCCESS (0.537s)
[240.622280] Starting dynamic subtest: vcs1
[241.151515] Dynamic subtest vcs1: SUCCESS (0.538s)
[241.161113] Starting dynamic subtest: vecs0
[241.689730] Dynamic subtest vecs0: SUCCESS (0.538s)
[241.690511] Subtest busy: SUCCESS (3.273s)
[241.993722] [045/133] (788s left) gen9_exec_parse (bb-secure)
[242.041513] Subtest bb-secure: SKIP (0.000s)
[242.120481] [046/133] (788s left) kms_cursor_edge_walk (128x128-right-edge)
[243.602060] Starting subtest: 128x128-right-edge
[243.602957] Starting dynamic subtest: pipe-A-HDMI-A-1
[246.938063] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (3.335s)
[246.952356] Starting dynamic subtest: pipe-D-HDMI-A-1
[250.152788] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (3.212s)
[250.153662] Subtest 128x128-right-edge: SUCCESS (6.552s)
[250.384813] [047/133] (779s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-mmap-gtt)
[251.871225] Starting subtest: psr-2p-primscrn-pri-indfb-draw-mmap-gtt
[251.872799] Subtest psr-2p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[252.099815] [048/133] (778s left) prime_mmap (test_forked_cpu_write)
[252.142493] Starting subtest: test_forked_cpu_write
[252.143278] Starting dynamic subtest: test_forked_cpu_write-smem
[252.154094] Dynamic subtest test_forked_cpu_write-smem: SUCCESS (0.011s)
[252.163732] Starting dynamic subtest: test_forked_cpu_write-lmem0
[252.166146] Dynamic subtest test_forked_cpu_write-lmem0: SUCCESS (0.011s)
[252.166940] Subtest test_forked_cpu_write: SUCCESS (0.024s)
[252.379811] [049/133] (778s left) kms_addfb_basic (small-bo)
[253.867049] Starting subtest: small-bo
[253.868084] Subtest small-bo: SUCCESS (0.000s)
[254.065447] [050/133] (776s left) kms_chamelium_audio (dp-audio)
[255.598126] Subtest dp-audio: SKIP (0.000s)
[255.709729] [051/133] (774s left) kms_chamelium_edid (hdmi-edid-change-during-suspend)
[257.240625] Subtest hdmi-edid-change-during-suspend: SKIP (0.000s)
[257.352506] [052/133] (773s left) kms_frontbuffer_tracking (psr-shrfb-scaledprimary)
[258.839558] Starting subtest: psr-shrfb-scaledprimary
[258.841181] Subtest psr-shrfb-scaledprimary: SKIP (0.000s)
[259.094165] [053/133] (771s left) kms_flip_scaled_crc (flip-32bpp-yftile-to-32bpp-yftileccs-downscaling)
[260.576133] Starting subtest: flip-32bpp-yftile-to-32bpp-yftileccs-downscaling
[260.577981] Subtest flip-32bpp-yftile-to-32bpp-yftileccs-downscaling: SKIP (0.000s)
[260.798880] [054/133] (770s left) perf (i915-ref-count)
[260.956326] Starting subtest: i915-ref-count
[260.991148] Subtest i915-ref-count: SUCCESS (0.035s)
[261.068524] [055/133] (770s left) kms_joiner (invalid-modeset-force-big-joiner)
[262.554800] Starting subtest: invalid-modeset-force-big-joiner
[262.556509] Subtest invalid-modeset-force-big-joiner: SKIP (0.000s)
[262.758456] [056/133] (768s left) kms_cursor_crc (cursor-alpha-opaque)
[264.239997] Starting subtest: cursor-alpha-opaque
[264.242198] Starting dynamic subtest: pipe-A-HDMI-A-1
[264.912599] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.670s)
[264.923445] Starting dynamic subtest: pipe-D-HDMI-A-1
[265.333920] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.419s)
[265.334833] Subtest cursor-alpha-opaque: SUCCESS (1.093s)
[266.077353] [057/133] (765s left) kms_legacy_colorkey (basic)
[267.557791] Starting subtest: basic
[267.558642] Starting dynamic subtest: pipe-A
[267.649918] Dynamic subtest pipe-A: SUCCESS (0.092s)
[267.671738] Starting dynamic subtest: pipe-B
[267.673164] Dynamic subtest pipe-B: SUCCESS (0.001s)
[267.714386] Starting dynamic subtest: pipe-C
[267.716298] Dynamic subtest pipe-C: SUCCESS (0.002s)
[267.763455] Starting dynamic subtest: pipe-D
[267.765074] Dynamic subtest pipe-D: SUCCESS (0.002s)
[267.766630] Subtest basic: SUCCESS (0.101s)
[267.841072] [058/133] (763s left) kms_big_fb (linear-max-hw-stride-64bpp-rotate-180-hflip)
[269.343808] Starting subtest: linear-max-hw-stride-64bpp-rotate-180-hflip
[269.345430] Subtest linear-max-hw-stride-64bpp-rotate-180-hflip: SKIP (0.000s)
[269.564947] [059/133] (761s left) kms_addfb_basic (bad-pitch-32)
[269.609205] Starting subtest: bad-pitch-32
[269.610138] Subtest bad-pitch-32: SUCCESS (0.000s)
[271.275415] [060/133] (760s left) gem_render_copy (x-tiled-to-vebox-y-tiled)
[271.327174] Starting subtest: x-tiled-to-vebox-y-tiled
[271.328027] Starting dynamic subtest: smem
[271.412598] Dynamic subtest smem: SUCCESS (0.085s)
[271.422272] Starting dynamic subtest: lmem0
[272.167925] Dynamic subtest lmem0: SUCCESS (0.751s)
[272.168880] Subtest x-tiled-to-vebox-y-tiled: SUCCESS (0.838s)
[272.472607] [061/133] (759s left) gem_exec_reloc (basic-range)
[272.522164] Subtest basic-range: SKIP (0.000s)
[272.626207] [062/133] (759s left) kms_big_fb (yf-tiled-64bpp-rotate-0)
[274.125677] Starting subtest: yf-tiled-64bpp-rotate-0
[274.127331] Subtest yf-tiled-64bpp-rotate-0: SKIP (0.000s)
[274.349391] [063/133] (757s left) syncobj_wait (wait-all-for-submit-snapshot)
[274.393468] Starting subtest: wait-all-for-submit-snapshot
[274.476793] Subtest wait-all-for-submit-snapshot: SUCCESS (0.082s)
[274.684014] [064/133] (757s left) kms_async_flips (invalid-async-flip)
[276.166080] Starting subtest: invalid-async-flip
[276.432807] Starting dynamic subtest: pipe-A-HDMI-A-1
[276.872099] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.439s)
[277.051032] Starting dynamic subtest: pipe-B-HDMI-A-1
[277.138248] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.096s)
[277.312130] Starting dynamic subtest: pipe-C-HDMI-A-1
[277.411823] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.108s)
[277.564883] Starting dynamic subtest: pipe-D-HDMI-A-1
[277.662159] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.106s)
[277.663033] Subtest invalid-async-flip: SUCCESS (1.497s)
[278.075195] [065/133] (754s left) kms_flip (single-buffer-flip-vs-dpms-off-vs-modeset-interruptible)
[279.563344] Starting subtest: single-buffer-flip-vs-dpms-off-vs-modeset-interruptible
[279.568548] Starting dynamic subtest: A-HDMI-A1
[280.246676] Dynamic subtest A-HDMI-A1: SUCCESS (0.678s)
[280.256363] Starting dynamic subtest: B-HDMI-A1
[280.905521] Dynamic subtest B-HDMI-A1: SUCCESS (0.657s)
[280.915521] Starting dynamic subtest: C-HDMI-A1
[281.575830] Dynamic subtest C-HDMI-A1: SUCCESS (0.668s)
[281.585514] Starting dynamic subtest: D-HDMI-A1
[282.252417] Dynamic subtest D-HDMI-A1: SUCCESS (0.677s)
[282.255428] Subtest single-buffer-flip-vs-dpms-off-vs-modeset-interruptible: SUCCESS (2.692s)
[282.466229] [066/133] (749s left) kms_frontbuffer_tracking (fbc-suspend)
[283.955988] Starting subtest: fbc-suspend
[329.785444] Subtest fbc-suspend: SUCCESS (22.650s)
[334.039439] [067/133] (702s left) syncobj_timeline (invalid-transfer-bad-pad)
[334.084980] Starting subtest: invalid-transfer-bad-pad
[334.085783] Subtest invalid-transfer-bad-pad: SUCCESS (0.000s)
[334.227318] [068/133] (702s left) kms_big_fb (4-tiled-64bpp-rotate-90)
[335.730537] Starting subtest: 4-tiled-64bpp-rotate-90
[335.732517] Subtest 4-tiled-64bpp-rotate-90: SKIP (0.000s)
[335.999099] [069/133] (700s left) gem_ctx_persistence (saturated-hostile-nopreempt)
[336.048489] Starting subtest: saturated-hostile-nopreempt
[336.049415] Starting dynamic subtest: rcs0
[336.859811] Dynamic subtest rcs0: SUCCESS (0.810s)
[336.875807] Starting dynamic subtest: bcs0
[337.626712] Dynamic subtest bcs0: SUCCESS (0.765s)
[337.640781] Starting dynamic subtest: vcs0
[338.428321] Dynamic subtest vcs0: SUCCESS (0.799s)
[338.442029] Starting dynamic subtest: vcs1
[339.208230] Dynamic subtest vcs1: SUCCESS (0.777s)
[339.221543] Starting dynamic subtest: vecs0
[339.987314] Dynamic subtest vecs0: SUCCESS (0.776s)
[339.988248] Subtest saturated-hostile-nopreempt: SUCCESS (3.940s)
[340.198298] [070/133] (696s left) gem_exec_big (single)
[340.247946] Starting subtest: single
[347.572743] Subtest single: SUCCESS (7.323s)
[348.492491] [071/133] (688s left) gem_exec_fence (submit67)
[348.706028] Starting subtest: submit67
[348.707717] Subtest submit67: SKIP (0.000s)
[349.347343] [072/133] (687s left) kms_frontbuffer_tracking (psr-2p-scndscrn-shrfb-pgflip-blt)
[350.839251] Starting subtest: psr-2p-scndscrn-shrfb-pgflip-blt
[350.840930] Subtest psr-2p-scndscrn-shrfb-pgflip-blt: SKIP (0.000s)
[351.034269] [073/133] (685s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-mmap-wc)
[352.521090] Starting subtest: fbc-rgb101010-draw-mmap-wc
[352.522972] Subtest fbc-rgb101010-draw-mmap-wc: SKIP (0.000s)
[352.765262] [074/133] (684s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-mmap-gtt)
[354.252536] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-mmap-gtt
[354.254465] Subtest fbc-1p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[354.474312] [075/133] (682s left) i915_drm_fdinfo (busy-idle)
[354.523113] Starting subtest: busy-idle
[354.524196] Starting dynamic subtest: rcs0
[354.525831] Dynamic subtest rcs0: SKIP (0.000s)
[354.538068] Starting dynamic subtest: bcs0
[354.540075] Dynamic subtest bcs0: SKIP (0.000s)
[354.551918] Starting dynamic subtest: vcs0
[354.554138] Dynamic subtest vcs0: SKIP (0.000s)
[354.566211] Starting dynamic subtest: vcs1
[354.568078] Dynamic subtest vcs1: SKIP (0.000s)
[354.580083] Starting dynamic subtest: vecs0
[354.582345] Dynamic subtest vecs0: SKIP (0.000s)
[354.584208] Subtest busy-idle: SKIP (0.009s)
[354.666921] [076/133] (682s left) kms_psr (psr2-primary-page-flip)
[356.149466] Subtest psr2-primary-page-flip: SKIP (0.000s)
[356.229435] [077/133] (680s left) kms_cursor_legacy (cursora-vs-flipb-atomic)
[357.711824] Starting subtest: cursorA-vs-flipB-atomic
[357.715056] Subtest cursorA-vs-flipB-atomic: SKIP (0.002s)
[357.924651] [078/133] (679s left) kms_prop_blob (blob-prop-lifetime)
[357.968673] Starting subtest: blob-prop-lifetime
[357.969608] Subtest blob-prop-lifetime: SUCCESS (0.001s)
[358.177701] [079/133] (679s left) kms_plane_scaling (plane-scaler-with-clipping-clamping-pixel-formats)
[359.660818] Starting subtest: plane-scaler-with-clipping-clamping-pixel-formats
[359.661658] Starting dynamic subtest: pipe-A
[362.117813] Dynamic subtest pipe-A: SUCCESS (2.457s)
[362.140187] Starting dynamic subtest: pipe-B
[364.473906] Dynamic subtest pipe-B: SUCCESS (2.354s)
[364.489680] Starting dynamic subtest: pipe-C
[364.764049] Dynamic subtest pipe-C: SUCCESS (0.289s)
[364.779557] Starting dynamic subtest: pipe-D
[365.054334] Dynamic subtest pipe-D: SUCCESS (0.289s)
[365.055437] Subtest plane-scaler-with-clipping-clamping-pixel-formats: SUCCESS (5.395s)
[365.326966] [080/133] (672s left) kms_pipe_crc_basic (hang-read-crc)
[366.817937] Starting subtest: hang-read-crc
[366.820395] Starting dynamic subtest: pipe-A-HDMI-A-1
[368.311913] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (1.492s)
[368.326090] Starting dynamic subtest: pipe-B-HDMI-A-1
[369.497685] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (1.183s)
[369.511941] Starting dynamic subtest: pipe-C-HDMI-A-1
[370.742888] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (1.242s)
[370.756778] Starting dynamic subtest: pipe-D-HDMI-A-1
[371.942810] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (1.197s)
[371.943668] Subtest hang-read-crc: SUCCESS (5.126s)
[372.154997] [081/133] (665s left) kms_selftest (drm_format)
[372.212712] Starting subtest: drm_format
[372.223785] Starting dynamic subtest: drm_test_format_block_width_invalid
[372.309852] Dynamic subtest drm_test_format_block_width_invalid: SUCCESS (0.087s)
[372.326101] Starting dynamic subtest: drm_test_format_block_width_one_plane
[372.401966] Dynamic subtest drm_test_format_block_width_one_plane: SUCCESS (0.086s)
[372.415734] Starting dynamic subtest: drm_test_format_block_width_two_plane
[372.491423] Dynamic subtest drm_test_format_block_width_two_plane: SUCCESS (0.085s)
[372.537893] Starting dynamic subtest: drm_test_format_block_width_three_plane
[372.578549] Dynamic subtest drm_test_format_block_width_three_plane: SUCCESS (0.082s)
[372.603073] Starting dynamic subtest: drm_test_format_block_width_tiled
[372.654612] Dynamic subtest drm_test_format_block_width_tiled: SUCCESS (0.071s)
[372.698954] Starting dynamic subtest: drm_test_format_block_height_invalid
[372.739581] Dynamic subtest drm_test_format_block_height_invalid: SUCCESS (0.079s)
[372.763782] Starting dynamic subtest: drm_test_format_block_height_one_plane
[372.834974] Dynamic subtest drm_test_format_block_height_one_plane: SUCCESS (0.091s)
[372.882472] Starting dynamic subtest: drm_test_format_block_height_two_plane
[372.923797] Dynamic subtest drm_test_format_block_height_two_plane: SUCCESS (0.082s)
[372.947995] Starting dynamic subtest: drm_test_format_block_height_three_plane
[373.010407] Dynamic subtest drm_test_format_block_height_three_plane: SUCCESS (0.082s)
[373.025198] Starting dynamic subtest: drm_test_format_block_height_tiled
[373.095850] Dynamic subtest drm_test_format_block_height_tiled: SUCCESS (0.081s)
[373.137375] Starting dynamic subtest: drm_test_format_min_pitch_invalid
[373.177678] Dynamic subtest drm_test_format_min_pitch_invalid: SUCCESS (0.077s)
[373.211867] Starting dynamic subtest: drm_test_format_min_pitch_one_plane_8bpp
[373.249516] Dynamic subtest drm_test_format_min_pitch_one_plane_8bpp: SUCCESS (0.068s)
[373.277049] Starting dynamic subtest: drm_test_format_min_pitch_one_plane_16bpp
[373.320792] Dynamic subtest drm_test_format_min_pitch_one_plane_16bpp: SUCCESS (0.069s)
[373.357454] Starting dynamic subtest: drm_test_format_min_pitch_one_plane_24bpp
[373.399505] Dynamic subtest drm_test_format_min_pitch_one_plane_24bpp: SUCCESS (0.073s)
[373.430625] Starting dynamic subtest: drm_test_format_min_pitch_one_plane_32bpp
[373.492354] Dynamic subtest drm_test_format_min_pitch_one_plane_32bpp: SUCCESS (0.088s)
[373.538354] Starting dynamic subtest: drm_test_format_min_pitch_two_plane
[373.579602] Dynamic subtest drm_test_format_min_pitch_two_plane: SUCCESS (0.081s)
[373.604023] Starting dynamic subtest: drm_test_format_min_pitch_three_plane_8bpp
[373.647953] Dynamic subtest drm_test_format_min_pitch_three_plane_8bpp: SUCCESS (0.064s)
[373.663764] Starting dynamic subtest: drm_test_format_min_pitch_tiled
[373.718969] Dynamic subtest drm_test_format_min_pitch_tiled: SUCCESS (0.067s)
[373.720116] Subtest drm_format: SUCCESS (1.507s)
[373.930793] [082/133] (663s left) gem_close_race (multigpu-basic-process)
[374.001229] Starting subtest: multigpu-basic-process
[374.003019] Subtest multigpu-basic-process: SKIP (0.000s)
[374.333004] [083/133] (663s left) gem_set_tiling_vs_gtt
[374.454107] [084/133] (663s left) kms_plane_scaling (planes-downscale-factor-0-5-unity-scaling)
[375.936869] Starting subtest: planes-downscale-factor-0-5-unity-scaling
[375.937706] Starting dynamic subtest: pipe-A
[376.098157] Dynamic subtest pipe-A: SUCCESS (0.161s)
[376.113666] Starting dynamic subtest: pipe-B
[376.239469] Dynamic subtest pipe-B: SUCCESS (0.140s)
[376.253046] Starting dynamic subtest: pipe-C
[376.379135] Dynamic subtest pipe-C: SUCCESS (0.138s)
[376.392925] Starting dynamic subtest: pipe-D
[376.519005] Dynamic subtest pipe-D: SUCCESS (0.139s)
[376.519847] Subtest planes-downscale-factor-0-5-unity-scaling: SUCCESS (0.584s)
[376.728201] [085/133] (661s left) kms_addfb_basic (basic-y-tiled-legacy)
[376.773829] Starting subtest: basic-y-tiled-legacy
[376.775493] Subtest basic-y-tiled-legacy: SKIP (0.000s)
[378.460186] [086/133] (659s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-0)
[379.982724] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-0
[381.260317] Subtest x-tiled-max-hw-stride-32bpp-rotate-0: SUCCESS (1.276s)
[381.532857] [087/133] (656s left) gem_render_copy (y-tiled-mc-ccs-to-yf-tiled-ccs)
[381.583812] Starting subtest: y-tiled-mc-ccs-to-yf-tiled-ccs
[381.584719] Starting dynamic subtest: smem
[381.682489] Dynamic subtest smem: SUCCESS (0.098s)
[381.696256] Starting dynamic subtest: lmem0
[382.797320] Dynamic subtest lmem0: SUCCESS (1.110s)
[382.798494] Subtest y-tiled-mc-ccs-to-yf-tiled-ccs: SUCCESS (1.211s)
[383.088895] [088/133] (655s left) gem_caching (writes)
[383.139956] Starting subtest: writes
[388.140911] Subtest writes: SUCCESS (5.002s)
[388.367922] [089/133] (649s left) syncobj_timeline (etime-multi-wait-for-submit-unsubmitted)
[388.415096] Starting subtest: etime-multi-wait-for-submit-unsubmitted
[388.522975] Subtest etime-multi-wait-for-submit-unsubmitted: SUCCESS (0.105s)
[388.679826] [090/133] (649s left) kms_flip (wf_vblank-ts-check)
[390.163677] Starting subtest: wf_vblank-ts-check
[390.167856] Starting dynamic subtest: A-HDMI-A1
[398.187597] Dynamic subtest A-HDMI-A1: SUCCESS (8.020s)
[398.204556] Starting dynamic subtest: B-HDMI-A1
[406.146945] Dynamic subtest B-HDMI-A1: SUCCESS (7.957s)
[406.161754] Starting dynamic subtest: C-HDMI-A1
[414.108085] Dynamic subtest C-HDMI-A1: SUCCESS (7.959s)
[414.122881] Starting dynamic subtest: D-HDMI-A1
[422.069548] Dynamic subtest D-HDMI-A1: SUCCESS (7.960s)
[422.073088] Subtest wf_vblank-ts-check: SUCCESS (31.911s)
[422.348222] [091/133] (616s left) gem_lmem_evict (dontneed-evict-race)
[426.709044] Starting subtest: dontneed-evict-race
[428.795011] Subtest dontneed-evict-race: SUCCESS (2.086s)
[430.628820] [FACT gem_lmem_evict (dontneed-evict-race)] deleted: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[430.630176] [FACT gem_lmem_evict (dontneed-evict-race)] deleted: kernel.kmod_is_loaded.i915: true
[430.632444] [092/133] (607s left) gem_mmap_gtt (medium-copy-odd)
[433.896235] Subtest medium-copy-odd: SKIP (0.000s)
[433.974340] [FACT gem_mmap_gtt (medium-copy-odd)] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[433.977450] [FACT gem_mmap_gtt (medium-copy-odd)] new: kernel.kmod_is_loaded.i915: true
[433.980947] [093/133] (604s left) kms_plane (pixel-format-4-tiled-dg2-mc-ccs-modifier)
[435.465550] Starting subtest: pixel-format-4-tiled-dg2-mc-ccs-modifier
[435.471897] Subtest pixel-format-4-tiled-dg2-mc-ccs-modifier: SKIP (0.000s)
[435.685210] [094/133] (603s left) kms_ccs (crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc)
[437.167862] Starting subtest: crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc
[437.170362] Starting dynamic subtest: pipe-A-HDMI-A-1
[437.192406] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.003s)
[437.202975] Starting dynamic subtest: pipe-B-HDMI-A-1
[437.225871] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.003s)
[437.236360] Starting dynamic subtest: pipe-C-HDMI-A-1
[437.265374] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.003s)
[437.275432] Starting dynamic subtest: pipe-D-HDMI-A-1
[437.294165] Dynamic subtest pipe-D-HDMI-A-1: SKIP (0.003s)
[437.295652] Subtest crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc: SKIP (0.020s)
[437.446336] [095/133] (601s left) gem_exec_suspend (basic-s0)
[437.505144] Starting subtest: basic-S0
[437.505974] Starting dynamic subtest: smem
[457.765145] Dynamic subtest smem: SUCCESS (5.337s)
[457.849013] Starting dynamic subtest: lmem0
[477.757331] Dynamic subtest lmem0: SUCCESS (5.354s)
[477.758269] Subtest basic-S0: SUCCESS (10.694s)
[484.167125] [096/133] (560s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-180)
[486.015949] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-180
[486.089043] Subtest 4-tiled-max-hw-stride-64bpp-rotate-180: SKIP (0.000s)
[486.306347] [097/133] (558s left) gem_mmap_offset (bad-extensions)
[486.532085] Starting subtest: bad-extensions
[486.603983] Subtest bad-extensions: SUCCESS (0.000s)
[486.881196] [098/133] (558s left) kms_cursor_legacy (2x-long-nonblocking-modeset-vs-cursor-atomic)
[488.524794] Starting subtest: 2x-long-nonblocking-modeset-vs-cursor-atomic
[488.527024] Subtest 2x-long-nonblocking-modeset-vs-cursor-atomic: SKIP (0.003s)
[488.762114] [099/133] (556s left) gem_mmap_gtt (cpuset-big-copy-odd)
[488.891147] Subtest cpuset-big-copy-odd: SKIP (0.000s)
[489.090167] [100/133] (556s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-180-async-flip)
[490.671500] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-180-async-flip
[490.743767] Subtest yf-tiled-max-hw-stride-64bpp-rotate-180-async-flip: SKIP (0.000s)
[490.960148] [101/133] (555s left) kms_psr (fbc-psr2-sprite-render)
[492.654633] Subtest fbc-psr2-sprite-render: SKIP (0.000s)
[492.897491] [102/133] (553s left) kms_frontbuffer_tracking (fbcpsr-1p-shrfb-fliptrack-mmap-gtt)
[494.537817] Starting subtest: fbcpsr-1p-shrfb-fliptrack-mmap-gtt
[494.610111] Subtest fbcpsr-1p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s)
[494.843151] [103/133] (551s left) kms_ccs (crc-primary-basic-y-tiled-ccs)
[496.435076] Starting subtest: crc-primary-basic-y-tiled-ccs
[496.436102] Starting dynamic subtest: pipe-A-HDMI-A-1
[496.445773] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.001s)
[496.457273] Starting dynamic subtest: pipe-B-HDMI-A-1
[496.466569] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.001s)
[496.477866] Starting dynamic subtest: pipe-C-HDMI-A-1
[496.487816] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.001s)
[496.498815] Starting dynamic subtest: pipe-D-HDMI-A-1
[496.508813] Dynamic subtest pipe-D-HDMI-A-1: SKIP (0.001s)
[496.510821] Subtest crc-primary-basic-y-tiled-ccs: SKIP (0.014s)
[496.719236] [104/133] (549s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-pwrite)
[498.248269] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-pwrite
[498.249833] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[498.490714] [105/133] (548s left) api_intel_bb (add-remove-objects)
[498.534905] Starting subtest: add-remove-objects
[498.555768] Subtest add-remove-objects: SUCCESS (0.022s)
[498.806335] [106/133] (548s left) sysfs_heartbeat_interval (nopreempt)
[498.854701] Starting subtest: nopreempt
[498.856980] Starting dynamic subtest: vecs0
[502.971657] Dynamic subtest vecs0: SUCCESS (4.115s)
[502.985661] Starting dynamic subtest: vcs0
[506.972843] Dynamic subtest vcs0: SUCCESS (4.000s)
[506.986409] Starting dynamic subtest: bcs0
[510.978929] Dynamic subtest bcs0: SUCCESS (4.004s)
[510.992914] Starting dynamic subtest: rcs0
[515.050025] Dynamic subtest rcs0: SUCCESS (4.064s)
[515.086125] Starting dynamic subtest: vcs1
[519.062444] Dynamic subtest vcs1: SUCCESS (4.009s)
[519.063369] Subtest nopreempt: SUCCESS (20.208s)
[519.269089] [107/133] (527s left) kms_getfb (getfb2-into-addfb2)
[520.753882] Starting subtest: getfb2-into-addfb2
[520.754752] Subtest getfb2-into-addfb2: SUCCESS (0.000s)
[521.019607] [108/133] (526s left) gem_close (basic)
[521.092023] Starting subtest: basic
[521.092846] Subtest basic: SUCCESS (0.000s)
[521.307552] [109/133] (525s left) gem_exec_schedule (preemptive-hang)
[521.478643] Starting subtest: preemptive-hang
[521.479589] Starting dynamic subtest: rcs0
[530.808654] Dynamic subtest rcs0: SUCCESS (9.331s)
[530.822083] Starting dynamic subtest: bcs0
[539.829858] Dynamic subtest bcs0: SUCCESS (9.019s)
[539.842248] Starting dynamic subtest: vcs0
[548.800836] Dynamic subtest vcs0: SUCCESS (8.969s)
[548.813216] Starting dynamic subtest: vcs1
[557.820937] Dynamic subtest vcs1: SUCCESS (9.019s)
[557.834521] Starting dynamic subtest: vecs0
[566.775029] Dynamic subtest vecs0: SUCCESS (8.952s)
[566.775852] Subtest preemptive-hang: SUCCESS (45.297s)
[567.102134] [110/133] (480s left) i915_drm_fdinfo (virtual-busy-idle)
[567.149026] Starting subtest: virtual-busy-idle
[567.150725] Subtest virtual-busy-idle: SKIP (0.000s)
[567.304736] [111/133] (480s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-mmap-wc)
[568.792920] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-mmap-wc
[568.794422] Subtest fbc-1p-offscreen-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[569.031176] [112/133] (478s left) gem_linear_blits (interruptible)
[569.379115] Starting subtest: interruptible
[577.935006] Subtest interruptible: SUCCESS (8.555s)
[578.250331] [113/133] (469s left) gem_ctx_persistence (engines-mixed)
[578.356346] Starting subtest: engines-mixed
[578.357246] Starting dynamic subtest: rcs0
[578.433966] Dynamic subtest rcs0: SUCCESS (0.077s)
[578.450700] Starting dynamic subtest: bcs0
[578.477649] Dynamic subtest bcs0: SUCCESS (0.042s)
[578.497340] Starting dynamic subtest: vcs0
[578.538924] Dynamic subtest vcs0: SUCCESS (0.059s)
[578.555316] Starting dynamic subtest: vcs1
[578.604804] Dynamic subtest vcs1: SUCCESS (0.062s)
[578.637498] Starting dynamic subtest: vecs0
[578.680005] Dynamic subtest vecs0: SUCCESS (0.072s)
[578.688309] Subtest engines-mixed: SUCCESS (0.325s)
[578.930438] [114/133] (468s left) perf_pmu (init-wait)
[578.979641] Starting subtest: init-wait
[578.980671] Starting dynamic subtest: rcs0
[578.982968] Dynamic subtest rcs0: SUCCESS (0.002s)
[578.995237] Starting dynamic subtest: bcs0
[578.996211] Dynamic subtest bcs0: SUCCESS (0.001s)
[579.008140] Starting dynamic subtest: vcs0
[579.008970] Dynamic subtest vcs0: SUCCESS (0.001s)
[579.020935] Starting dynamic subtest: vcs1
[579.021975] Dynamic subtest vcs1: SUCCESS (0.001s)
[579.033863] Starting dynamic subtest: vecs0
[579.034988] Dynamic subtest vecs0: SUCCESS (0.001s)
[579.036067] Subtest init-wait: SUCCESS (0.011s)
[579.132527] [115/133] (468s left) gem_exec_reloc (basic-gtt-cpu-active)
[579.182745] Subtest basic-gtt-cpu-active: SKIP (0.000s)
[579.301297] [116/133] (468s left) kms_pm_lpsp (screens-disabled)
[581.828444] Starting subtest: screens-disabled
[581.830371] Subtest screens-disabled: SKIP (0.000s)
[582.057043] [117/133] (465s left) kms_flip (flip-vs-expired-vblank-interruptible)
[583.544050] Starting subtest: flip-vs-expired-vblank-interruptible
[583.549639] Starting dynamic subtest: A-HDMI-A1
[591.306856] Dynamic subtest A-HDMI-A1: SUCCESS (7.758s)
[591.323369] Starting dynamic subtest: B-HDMI-A1
[598.983555] Dynamic subtest B-HDMI-A1: SUCCESS (7.675s)
[598.998138] Starting dynamic subtest: C-HDMI-A1
[606.643427] Dynamic subtest C-HDMI-A1: SUCCESS (7.659s)
[606.658570] Starting dynamic subtest: D-HDMI-A1
[614.320137] Dynamic subtest D-HDMI-A1: SUCCESS (7.676s)
[614.323830] Subtest flip-vs-expired-vblank-interruptible: SUCCESS (30.782s)
[614.555154] [118/133] (433s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-move)
[616.042631] Starting subtest: psr-1p-primscrn-cur-indfb-move
[616.044592] Subtest psr-1p-primscrn-cur-indfb-move: SKIP (0.000s)
[616.296035] [119/133] (431s left) kms_atomic_transition (plane-all-modeset-transition-internal-panels)
[617.779936] Starting subtest: plane-all-modeset-transition-internal-panels
[617.781796] Subtest plane-all-modeset-transition-internal-panels: SKIP (0.000s)
[617.994595] [120/133] (430s left) gem_userptr_blits (stress-mm)
[618.054917] Starting subtest: stress-mm
[623.426169] Subtest stress-mm: SUCCESS (5.369s)
[623.646426] [121/133] (424s left) syncobj_eventfd (invalid-bad-flags)
[623.695714] Starting subtest: invalid-bad-flags
[623.696564] Subtest invalid-bad-flags: SUCCESS (0.000s)
[623.878189] [122/133] (424s left) kms_addfb_basic (framebuffer-vs-set-tiling)
[623.928759] Starting subtest: framebuffer-vs-set-tiling
[623.930599] Subtest framebuffer-vs-set-tiling: SKIP (0.000s)
[625.612408] [123/133] (423s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-indfb-msflip-blt)
[627.099301] Starting subtest: fbc-2p-scndscrn-indfb-msflip-blt
[627.101077] Subtest fbc-2p-scndscrn-indfb-msflip-blt: SKIP (0.000s)
[627.352456] [124/133] (421s left) syncobj_timeline (multi-wait-for-submit-available-submitted-signaled)
[627.397095] Starting subtest: multi-wait-for-submit-available-submitted-signaled
[627.397942] Subtest multi-wait-for-submit-available-submitted-signaled: SUCCESS (0.001s)
[627.557164] [125/133] (421s left) kms_flip (2x-modeset-vs-vblank-race)
[629.040056] Starting subtest: 2x-modeset-vs-vblank-race
[629.061109] Subtest 2x-modeset-vs-vblank-race: SKIP (0.021s)
[629.256407] [126/133] (419s left) i915_query (query-regions-garbage-items)
[629.300750] Starting subtest: query-regions-garbage-items
[629.301428] Subtest query-regions-garbage-items: SUCCESS (0.000s)
[629.447575] [127/133] (419s left) kms_psr_stress_test (flip-primary-invalidate-overlay)
[629.491357] Subtest flip-primary-invalidate-overlay: SKIP (0.000s)
[629.588259] [128/133] (419s left) gem_exec_balancer (full-late)
[629.642068] Starting subtest: full-late
[631.970623] Subtest full-late: SUCCESS (2.329s)
[632.479167] [129/133] (416s left) gem_exec_reloc (basic-write-wc)
[632.527869] Subtest basic-write-wc: SKIP (0.000s)
[632.639841] [130/133] (416s left) kms_force_connector_basic (force-load-detect)
[632.790980] Starting subtest: force-load-detect
[632.792531] Subtest force-load-detect: SKIP (0.000s)
[633.799199] [131/133] (415s left) kms_chamelium_hpd (hdmi-hpd-fast)
[635.332353] Subtest hdmi-hpd-fast: SKIP (0.000s)
[635.447693] [132/133] (414s left) kms_flip_scaled_crc (flip-64bpp-xtile-to-32bpp-xtile-upscaling)
[636.930802] Starting subtest: flip-64bpp-xtile-to-32bpp-xtile-upscaling
[636.931824] Starting dynamic subtest: pipe-A-valid-mode
[637.761020] Dynamic subtest pipe-A-valid-mode: SUCCESS (0.829s)
[637.761968] Subtest flip-64bpp-xtile-to-32bpp-xtile-upscaling: SUCCESS (0.832s)
[637.971978] [133/133] (411s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-mmap-cpu)
[639.467769] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-mmap-cpu
[639.471335] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[639.684824] 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.