[56.765228] Initializing watchdogs
[56.765276]   /dev/watchdog0
[56.779643] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7d55 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Arc Graphics]
[56.784126] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[56.786389] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[56.789825] [001/133] (960s left) kms_content_protection (dp-mst-lic-type-0-hdcp14)
[56.952867] Starting subtest: dp-mst-lic-type-0-hdcp14
[56.957154] Subtest dp-mst-lic-type-0-hdcp14: SKIP (0.000s)
[57.097881] [002/133] (960s left) core_getversion (all-cards)
[57.136045] Starting subtest: all-cards
[57.142564] Subtest all-cards: SUCCESS (0.009s)
[57.181961] [003/133] (960s left) kms_atomic_interruptible (legacy-dpms)
[57.272697] Starting subtest: legacy-dpms
[57.274942] Starting dynamic subtest: pipe-A-eDP-1
[64.688844] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.452s)
[64.691261] Subtest legacy-dpms: SUCCESS (7.453s)
[65.496515] [004/133] (951s left) kms_plane (pixel-format-y-tiled-ccs-modifier-source-clamping)
[65.595218] Starting subtest: pixel-format-y-tiled-ccs-modifier-source-clamping
[65.608930] Subtest pixel-format-y-tiled-ccs-modifier-source-clamping: SKIP (0.000s)
[65.689836] [005/133] (951s left) kms_atomic_transition (plane-primary-toggle-with-vblank-wait)
[65.788314] Starting subtest: plane-primary-toggle-with-vblank-wait
[65.790662] Starting dynamic subtest: pipe-A-eDP-1
[65.959829] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.174s)
[66.260834] Starting dynamic subtest: pipe-B-eDP-1
[67.178683] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.925s)
[67.475503] Subtest plane-primary-toggle-with-vblank-wait: SUCCESS (1.692s)
[68.340633] [006/133] (949s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-mmap-gtt)
[68.446234] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-mmap-gtt
[68.450402] Subtest fbc-2p-scndscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[68.567036] [007/133] (948s left) kms_psr (fbc-psr2-primary-mmap-cpu)
[68.664216] Starting subtest: fbc-psr2-primary-mmap-cpu
[68.666475] Starting dynamic subtest: eDP-1
[68.670647] Dynamic subtest eDP-1: SKIP (0.000s)
[68.675055] Subtest fbc-psr2-primary-mmap-cpu: SKIP (0.001s)
[68.760027] [008/133] (948s left) perf (invalid-oa-exponent)
[68.895345] Starting subtest: invalid-oa-exponent
[68.911524] Subtest invalid-oa-exponent: SUCCESS (0.014s)
[68.956095] [009/133] (948s left) gem_eio (create-ext)
[69.108619] Starting subtest: create-ext
[69.288782] Subtest create-ext: SUCCESS (0.181s)
[69.441805] [010/133] (948s left) kms_color (invalid-degamma-lut-sizes)
[69.540783] Starting subtest: invalid-degamma-lut-sizes
[69.542568] Starting dynamic subtest: pipe-A
[69.829232] Dynamic subtest pipe-A: SUCCESS (0.289s)
[69.837651] Starting dynamic subtest: pipe-B
[69.839920] Dynamic subtest pipe-B: SUCCESS (0.000s)
[69.847053] Starting dynamic subtest: pipe-C
[69.849317] Dynamic subtest pipe-C: SUCCESS (0.000s)
[69.856368] Starting dynamic subtest: pipe-D
[69.858659] Dynamic subtest pipe-D: SUCCESS (0.000s)
[69.860544] Subtest invalid-degamma-lut-sizes: SUCCESS (0.291s)
[70.661729] [011/133] (946s left) gem_softpin (allocator-basic)
[70.725185] Starting subtest: allocator-basic
[70.796738] Subtest allocator-basic: SUCCESS (0.073s)
[70.957341] [012/133] (946s left) kms_psr2_sf (psr2-overlay-plane-update-sf-dmg-area)
[71.060762] Starting subtest: psr2-overlay-plane-update-sf-dmg-area
[71.063059] Starting dynamic subtest: pipe-A-eDP-1
[76.940465] Dynamic subtest pipe-A-eDP-1: SUCCESS (5.888s)
[76.950163] Starting dynamic subtest: pipe-B-eDP-1
[83.602088] Dynamic subtest pipe-B-eDP-1: SUCCESS (6.660s)
[83.604437] Subtest psr2-overlay-plane-update-sf-dmg-area: SUCCESS (12.551s)
[84.484766] [013/133] (933s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-0)
[84.586334] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-0
[84.590429] Subtest y-tiled-max-hw-stride-64bpp-rotate-0: SKIP (0.000s)
[84.706581] [014/133] (933s left) kms_psr (pr-primary-render)
[84.806113] Starting subtest: pr-primary-render
[84.810705] Subtest pr-primary-render: SKIP (0.000s)
[84.885412] [015/133] (932s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-pwrite)
[84.987423] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-pwrite
[84.991861] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[85.103600] [016/133] (932s left) kms_psr2_sf (pr-cursor-plane-move-continuous-exceed-sf)
[85.208502] Starting subtest: pr-cursor-plane-move-continuous-exceed-sf
[85.212743] Subtest pr-cursor-plane-move-continuous-exceed-sf: SKIP (0.000s)
[85.286239] [017/133] (932s left) gem_ccs (ctrl-surf-copy)
[85.354764] Starting subtest: ctrl-surf-copy
[85.358742] Subtest ctrl-surf-copy: SKIP (0.000s)
[85.476330] [018/133] (932s left) perf (invalid-oa-metric-set-id)
[85.571635] Starting subtest: invalid-oa-metric-set-id
[85.578278] Subtest invalid-oa-metric-set-id: SUCCESS (0.008s)
[85.617770] [019/133] (932s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-pwrite)
[85.714883] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-pwrite
[85.718325] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[85.838478] [020/133] (932s left) gem_pxp (create-regular-buffer)
[85.961505] Starting subtest: create-regular-buffer
[85.963607] Subtest create-regular-buffer: SUCCESS (0.000s)
[86.090508] [021/133] (931s left) gem_eio (in-flight-contexts-10ms)
[86.284145] Starting subtest: in-flight-contexts-10ms
[97.905503] Subtest in-flight-contexts-10ms: SUCCESS (11.618s)
[98.101233] [022/133] (919s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-render)
[98.210752] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-render
[104.986068] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-render: SUCCESS (6.778s)
[105.135603] [023/133] (912s left) gem_exec_schedule (u-fairslice-all)
[105.202816] Starting subtest: u-fairslice-all
[107.254844] Subtest u-fairslice-all: SUCCESS (2.055s)
[107.555766] [024/133] (910s left) core_getstats (basic)
[107.616708] Starting subtest: basic
[107.618837] Subtest basic: SUCCESS (0.000s)
[107.738977] [025/133] (910s left) kms_ccs (crc-primary-rotation-180-4-tiled-mtl-rc-ccs)
[107.829948] Starting subtest: crc-primary-rotation-180-4-tiled-mtl-rc-ccs
[107.832289] Starting dynamic subtest: pipe-A-eDP-1
[108.665696] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.830s)
[108.674390] Starting dynamic subtest: pipe-B-eDP-1
[110.231611] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.564s)
[110.241040] Starting dynamic subtest: pipe-C-eDP-1
[111.714992] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.480s)
[111.724469] Starting dynamic subtest: pipe-D-eDP-1
[113.246744] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.533s)
[113.249076] Subtest crc-primary-rotation-180-4-tiled-mtl-rc-ccs: SUCCESS (5.410s)
[114.442286] [026/133] (903s left) kms_ccs (bad-pixel-format-4-tiled-dg2-mc-ccs)
[114.540330] Starting subtest: bad-pixel-format-4-tiled-dg2-mc-ccs
[114.542610] Starting dynamic subtest: pipe-A-eDP-1
[114.565765] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[114.578327] Starting dynamic subtest: pipe-B-eDP-1
[114.599777] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[114.607185] Starting dynamic subtest: pipe-C-eDP-1
[114.628881] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[114.636430] Starting dynamic subtest: pipe-D-eDP-1
[114.658384] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[114.662447] Subtest bad-pixel-format-4-tiled-dg2-mc-ccs: SKIP (0.003s)
[116.718915] [027/133] (901s left) sw_sync (alloc_fence)
[116.765945] Starting subtest: alloc_fence
[116.768282] Subtest alloc_fence: SUCCESS (0.000s)
[116.834468] [028/133] (901s left) i915_pm_rps (basic-api)
[116.897699] Starting subtest: basic-api
[116.901967] Subtest basic-api: SKIP (0.001s)
[117.015989] [029/133] (901s left) kms_cursor_legacy (cursorb-vs-flipa-toggle)
[117.120959] Starting subtest: cursorB-vs-flipA-toggle
[117.125263] Subtest cursorB-vs-flipA-toggle: SKIP (0.001s)
[117.274943] [030/133] (901s left) kms_cursor_crc (cursor-rapid-movement-128x42)
[117.486567] Starting subtest: cursor-rapid-movement-128x42
[117.534168] Subtest cursor-rapid-movement-128x42: SKIP (0.043s)
[117.776202] [031/133] (900s left) kms_dp_link_training (non-uhbr-sst)
[117.869421] Starting subtest: non-uhbr-sst
[117.876447] Subtest non-uhbr-sst: SKIP (0.000s)
[117.960355] [032/133] (900s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-mmap-cpu)
[118.063122] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-mmap-cpu
[118.066502] Subtest psr-2p-scndscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[118.169787] [033/133] (900s left) gem_exec_parallel (engines)
[118.238038] Starting subtest: engines
[118.240049] Starting dynamic subtest: basic
[119.911084] Dynamic subtest basic: SUCCESS (1.670s)
[119.919875] Starting dynamic subtest: contexts
[124.391744] Dynamic subtest contexts: SUCCESS (4.478s)
[124.400958] Starting dynamic subtest: fds
[128.177880] Dynamic subtest fds: SUCCESS (3.784s)
[128.189050] Starting dynamic subtest: userptr
[129.916398] Dynamic subtest userptr: SUCCESS (1.738s)
[129.918997] Subtest engines: SUCCESS (11.678s)
[130.115902] [034/133] (888s left) gem_eio (in-flight-immediate)
[130.380747] Starting subtest: in-flight-immediate
[139.162037] Subtest in-flight-immediate: SUCCESS (8.782s)
[139.356095] [FACT gem_eio (in-flight-immediate)] new: kernel.kmod_is_loaded.vgem: true
[139.359341] [035/133] (879s left) prime_mmap (test_forked)
[139.416785] Starting subtest: test_forked
[139.419086] Starting dynamic subtest: test_forked-smem
[139.460444] Dynamic subtest test_forked-smem: SUCCESS (0.043s)
[139.463080] Subtest test_forked: SUCCESS (0.045s)
[139.581351] [036/133] (878s left) kms_dsc (dsc-with-formats)
[139.683137] Starting subtest: dsc-with-formats
[139.723055] Subtest dsc-with-formats: SKIP (0.001s)
[139.784099] [037/133] (878s left) prime_busy (hang)
[139.838167] Starting subtest: hang
[139.840519] Starting dynamic subtest: rcs0
[166.448376] Dynamic subtest rcs0: SUCCESS (26.606s)
[166.457551] Starting dynamic subtest: bcs0
[173.540528] Dynamic subtest bcs0: SUCCESS (7.090s)
[173.550164] Starting dynamic subtest: vcs0
[180.578196] Dynamic subtest vcs0: SUCCESS (7.040s)
[180.586233] Starting dynamic subtest: vcs1
[187.552417] Dynamic subtest vcs1: SUCCESS (6.973s)
[187.560321] Starting dynamic subtest: vecs0
[194.590440] Dynamic subtest vecs0: SUCCESS (7.037s)
[194.600324] Starting dynamic subtest: ccs0
[208.429184] Dynamic subtest ccs0: SUCCESS (13.836s)
[208.431464] Subtest hang: SUCCESS (68.588s)
[208.591986] [038/133] (810s left) kms_vblank (wait-idle)
[208.698925] Starting subtest: wait-idle
[208.700878] Starting dynamic subtest: pipe-A-eDP-1
[210.452137] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.752s)
[210.465480] Starting dynamic subtest: pipe-D-eDP-1
[212.947912] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.495s)
[212.950114] Subtest wait-idle: SUCCESS (4.251s)
[213.772821] [039/133] (804s left) kms_pm_rpm (package-g7)
[216.100235] Starting subtest: package-g7
[216.105655] Subtest package-g7: SKIP (0.000s)
[216.483120] [040/133] (802s left) kms_cursor_legacy (flip-vs-cursor-varying-size)
[216.608957] Starting subtest: flip-vs-cursor-varying-size
[225.155067] Subtest flip-vs-cursor-varying-size: SUCCESS (8.545s)
[226.007228] [041/133] (792s left) kms_frontbuffer_tracking (psr-1p-primscrn-shrfb-msflip-blt)
[226.100415] Starting subtest: psr-1p-primscrn-shrfb-msflip-blt
[233.436434] Subtest psr-1p-primscrn-shrfb-msflip-blt: SUCCESS (7.338s)
[233.616449] [042/133] (785s left) syncobj_timeline (single-wait-all-for-submit-signaled)
[233.678996] Starting subtest: single-wait-all-for-submit-signaled
[233.681408] Subtest single-wait-all-for-submit-signaled: SUCCESS (0.000s)
[233.786803] [043/133] (785s left) perf (gen12-group-exclusive-stream-ctx-handle)
[233.881850] Starting subtest: gen12-group-exclusive-stream-ctx-handle
[233.911029] Subtest gen12-group-exclusive-stream-ctx-handle: SUCCESS (0.024s)
[233.952670] [044/133] (784s left) gem_wait (busy)
[235.907358] Starting subtest: busy
[235.909559] Starting dynamic subtest: all-engines
[237.844201] Dynamic subtest all-engines: SUCCESS (1.938s)
[237.855269] Starting dynamic subtest: rcs0
[238.386541] Dynamic subtest rcs0: SUCCESS (0.542s)
[238.396893] Starting dynamic subtest: bcs0
[238.927965] Dynamic subtest bcs0: SUCCESS (0.540s)
[238.938607] Starting dynamic subtest: vcs0
[240.916097] Dynamic subtest vcs0: SUCCESS (1.986s)
[240.927501] Starting dynamic subtest: vcs1
[242.900895] Dynamic subtest vcs1: SUCCESS (1.982s)
[242.912217] Starting dynamic subtest: vecs0
[244.883995] Dynamic subtest vecs0: SUCCESS (1.981s)
[244.895334] Starting dynamic subtest: ccs0
[245.425582] Dynamic subtest ccs0: SUCCESS (0.541s)
[245.428061] Subtest busy: SUCCESS (9.521s)
[245.631627] [045/133] (773s left) gen9_exec_parse (bb-secure)
[245.699720] Subtest bb-secure: SKIP (0.000s)
[245.801255] [046/133] (773s left) kms_cursor_edge_walk (128x128-right-edge)
[245.920053] Starting subtest: 128x128-right-edge
[245.922440] Starting dynamic subtest: pipe-A-eDP-1
[249.363654] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.442s)
[249.372115] Starting dynamic subtest: pipe-D-eDP-1
[252.488490] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.125s)
[252.490816] Subtest 128x128-right-edge: SUCCESS (6.569s)
[253.313762] [047/133] (765s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-mmap-gtt)
[253.425813] Starting subtest: psr-2p-primscrn-pri-indfb-draw-mmap-gtt
[253.429822] Subtest psr-2p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[253.548232] [048/133] (765s left) prime_mmap (test_forked_cpu_write)
[253.595812] Starting subtest: test_forked_cpu_write
[253.597670] Starting dynamic subtest: test_forked_cpu_write-smem
[253.601983] Dynamic subtest test_forked_cpu_write-smem: SUCCESS (0.007s)
[253.604277] Subtest test_forked_cpu_write: SUCCESS (0.008s)
[253.739338] [049/133] (765s left) kms_addfb_basic (small-bo)
[253.840035] Starting subtest: small-bo
[253.842334] Subtest small-bo: SUCCESS (0.000s)
[253.970550] [050/133] (765s left) kms_chamelium_audio (dp-audio)
[254.343647] Subtest dp-audio: SKIP (0.000s)
[255.118844] [051/133] (764s left) kms_chamelium_edid (hdmi-edid-change-during-suspend)
[255.519103] Subtest hdmi-edid-change-during-suspend: SKIP (0.000s)
[256.352138] [052/133] (762s left) kms_frontbuffer_tracking (psr-shrfb-scaledprimary)
[256.463819] Starting subtest: psr-shrfb-scaledprimary
[262.283470] Subtest psr-shrfb-scaledprimary: SUCCESS (5.822s)
[262.452978] [053/133] (756s left) kms_flip_scaled_crc (flip-32bpp-yftile-to-32bpp-yftileccs-downscaling)
[262.556077] Starting subtest: flip-32bpp-yftile-to-32bpp-yftileccs-downscaling
[262.560411] Subtest flip-32bpp-yftile-to-32bpp-yftileccs-downscaling: SKIP (0.000s)
[262.650963] [054/133] (756s left) perf (i915-ref-count)
[262.749092] Starting subtest: i915-ref-count
[262.770687] Subtest i915-ref-count: SUCCESS (0.022s)
[262.829651] [055/133] (756s left) kms_joiner (invalid-modeset-force-big-joiner)
[262.938299] Starting subtest: invalid-modeset-force-big-joiner
[262.942246] Subtest invalid-modeset-force-big-joiner: SKIP (0.000s)
[263.020197] [056/133] (756s left) kms_cursor_crc (cursor-alpha-opaque)
[263.109150] Starting subtest: cursor-alpha-opaque
[263.111205] Starting dynamic subtest: pipe-A-eDP-1
[263.736173] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.626s)
[263.748454] Starting dynamic subtest: pipe-D-eDP-1
[264.974248] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.236s)
[264.976255] Subtest cursor-alpha-opaque: SUCCESS (1.864s)
[265.782593] [057/133] (753s left) kms_legacy_colorkey (basic)
[265.886032] Starting subtest: basic
[265.887906] Starting dynamic subtest: pipe-A
[265.929573] Dynamic subtest pipe-A: SUCCESS (0.045s)
[265.941478] Starting dynamic subtest: pipe-B
[265.943689] Dynamic subtest pipe-B: SUCCESS (0.000s)
[265.951695] Starting dynamic subtest: pipe-C
[265.954045] Dynamic subtest pipe-C: SUCCESS (0.000s)
[265.961706] Starting dynamic subtest: pipe-D
[265.963858] Dynamic subtest pipe-D: SUCCESS (0.000s)
[265.966091] Subtest basic: SUCCESS (0.051s)
[266.018750] [058/133] (753s left) kms_big_fb (linear-max-hw-stride-64bpp-rotate-180-hflip)
[266.133486] Starting subtest: linear-max-hw-stride-64bpp-rotate-180-hflip
[266.138072] Subtest linear-max-hw-stride-64bpp-rotate-180-hflip: SKIP (0.000s)
[266.248360] [059/133] (753s left) kms_addfb_basic (bad-pitch-32)
[266.308627] Starting subtest: bad-pitch-32
[266.310987] Subtest bad-pitch-32: SUCCESS (0.000s)
[266.468823] [060/133] (753s left) gem_render_copy (x-tiled-to-vebox-y-tiled)
[266.527992] Starting subtest: x-tiled-to-vebox-y-tiled
[266.532731] Subtest x-tiled-to-vebox-y-tiled: SKIP (0.000s)
[266.724040] [061/133] (752s left) gem_exec_reloc (basic-range)
[266.791249] Subtest basic-range: SKIP (0.000s)
[266.878877] [062/133] (752s left) kms_big_fb (yf-tiled-64bpp-rotate-0)
[266.978290] Starting subtest: yf-tiled-64bpp-rotate-0
[266.982301] Subtest yf-tiled-64bpp-rotate-0: SKIP (0.000s)
[267.117813] [063/133] (752s left) syncobj_wait (wait-all-for-submit-snapshot)
[267.181091] Starting subtest: wait-all-for-submit-snapshot
[267.261533] Subtest wait-all-for-submit-snapshot: SUCCESS (0.081s)
[267.349304] [064/133] (752s left) kms_async_flips (invalid-async-flip)
[267.449556] Starting subtest: invalid-async-flip
[267.832052] Starting dynamic subtest: pipe-A-eDP-1
[268.611681] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.781s)
[268.973993] Starting dynamic subtest: pipe-B-eDP-1
[269.751313] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.786s)
[270.106912] Starting dynamic subtest: pipe-C-eDP-1
[270.877189] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.777s)
[271.230435] Starting dynamic subtest: pipe-D-eDP-1
[272.007137] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.783s)
[272.009662] Subtest invalid-async-flip: SUCCESS (4.561s)
[273.177965] [065/133] (746s left) kms_flip (single-buffer-flip-vs-dpms-off-vs-modeset-interruptible)
[273.278144] Starting subtest: single-buffer-flip-vs-dpms-off-vs-modeset-interruptible
[273.280317] Starting dynamic subtest: A-eDP1
[276.867018] Dynamic subtest A-eDP1: SUCCESS (3.584s)
[276.875897] Starting dynamic subtest: B-eDP1
[280.060599] Dynamic subtest B-eDP1: SUCCESS (3.193s)
[280.070030] Starting dynamic subtest: C-eDP1
[283.169840] Dynamic subtest C-eDP1: SUCCESS (3.108s)
[283.179077] Starting dynamic subtest: D-eDP1
[286.257349] Dynamic subtest D-eDP1: SUCCESS (3.086s)
[286.259866] Subtest single-buffer-flip-vs-dpms-off-vs-modeset-interruptible: SUCCESS (12.980s)
[287.067252] [066/133] (732s left) kms_frontbuffer_tracking (fbc-suspend)
[287.170173] Starting subtest: fbc-suspend
[325.407287] Subtest fbc-suspend: SUCCESS (8.320s)
[326.588970] [067/133] (693s left) syncobj_timeline (invalid-transfer-bad-pad)
[326.656634] Starting subtest: invalid-transfer-bad-pad
[326.658620] Subtest invalid-transfer-bad-pad: SUCCESS (0.000s)
[326.761733] [068/133] (693s left) kms_big_fb (4-tiled-64bpp-rotate-90)
[326.859130] Starting subtest: 4-tiled-64bpp-rotate-90
[326.878732] Subtest 4-tiled-64bpp-rotate-90: SKIP (0.019s)
[327.012942] [069/133] (692s left) gem_ctx_persistence (saturated-hostile-nopreempt)
[327.055421] Starting subtest: saturated-hostile-nopreempt
[327.057551] Starting dynamic subtest: rcs0
[327.141322] Dynamic subtest rcs0: SKIP (0.086s)
[327.152753] Starting dynamic subtest: bcs0
[327.160543] Dynamic subtest bcs0: SKIP (0.017s)
[327.171305] Starting dynamic subtest: vcs0
[327.181163] Dynamic subtest vcs0: SKIP (0.020s)
[327.189872] Starting dynamic subtest: vcs1
[327.203400] Dynamic subtest vcs1: SKIP (0.022s)
[327.212075] Starting dynamic subtest: vecs0
[327.218951] Dynamic subtest vecs0: SKIP (0.013s)
[327.227580] Starting dynamic subtest: ccs0
[327.238127] Dynamic subtest ccs0: SKIP (0.020s)
[327.242600] Subtest saturated-hostile-nopreempt: SKIP (0.186s)
[327.328186] [070/133] (692s left) gem_exec_big (single)
[327.398822] Starting subtest: single
[329.765633] Subtest single: SUCCESS (2.413s)
[329.982951] [071/133] (690s left) gem_exec_fence (submit67)
[330.208622] Starting subtest: submit67
[330.213034] Subtest submit67: SKIP (0.000s)
[332.012753] [072/133] (688s left) kms_frontbuffer_tracking (psr-2p-scndscrn-shrfb-pgflip-blt)
[332.110187] Starting subtest: psr-2p-scndscrn-shrfb-pgflip-blt
[332.114130] Subtest psr-2p-scndscrn-shrfb-pgflip-blt: SKIP (0.000s)
[332.215478] [073/133] (687s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-mmap-wc)
[332.320373] Starting subtest: fbc-rgb101010-draw-mmap-wc
[336.903831] Subtest fbc-rgb101010-draw-mmap-wc: SUCCESS (4.630s)
[338.028907] [074/133] (682s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-mmap-gtt)
[338.133559] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-mmap-gtt
[338.137638] Subtest fbc-1p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[338.235965] [075/133] (681s left) i915_drm_fdinfo (busy-idle)
[338.277127] Starting subtest: busy-idle
[338.278908] Starting dynamic subtest: rcs0
[338.317943] Dynamic subtest rcs0: SKIP (0.040s)
[338.329452] Starting dynamic subtest: bcs0
[338.333316] Dynamic subtest bcs0: SKIP (0.000s)
[338.342816] Starting dynamic subtest: vcs0
[338.347096] Dynamic subtest vcs0: SKIP (0.000s)
[338.355834] Starting dynamic subtest: vcs1
[338.359737] Dynamic subtest vcs1: SKIP (0.000s)
[338.368551] Starting dynamic subtest: vecs0
[338.372589] Dynamic subtest vecs0: SKIP (0.000s)
[338.381004] Starting dynamic subtest: ccs0
[338.385010] Dynamic subtest ccs0: SKIP (0.000s)
[338.389064] Subtest busy-idle: SKIP (0.047s)
[338.425325] [076/133] (681s left) kms_psr (psr2-primary-page-flip)
[338.518374] Starting subtest: psr2-primary-page-flip
[338.520727] Starting dynamic subtest: eDP-1
[340.261575] Dynamic subtest eDP-1: SUCCESS (1.750s)
[340.263479] Subtest psr2-primary-page-flip: SUCCESS (1.751s)
[341.152392] [077/133] (679s left) kms_cursor_legacy (cursora-vs-flipb-atomic)
[341.289970] Starting subtest: cursorA-vs-flipB-atomic
[341.294292] Subtest cursorA-vs-flipB-atomic: SKIP (0.001s)
[341.445694] [078/133] (678s left) kms_prop_blob (blob-prop-lifetime)
[341.506262] Starting subtest: blob-prop-lifetime
[341.508588] Subtest blob-prop-lifetime: SUCCESS (0.001s)
[341.637114] [079/133] (678s left) kms_plane_scaling (plane-scaler-with-clipping-clamping-pixel-formats)
[341.738012] Starting subtest: plane-scaler-with-clipping-clamping-pixel-formats
[341.740289] Starting dynamic subtest: pipe-A
[341.846978] Dynamic subtest pipe-A: SKIP (0.107s)
[341.856559] Starting dynamic subtest: pipe-B
[342.983751] Dynamic subtest pipe-B: SKIP (1.139s)
[342.993748] Starting dynamic subtest: pipe-C
[344.120781] Dynamic subtest pipe-C: SUCCESS (1.146s)
[344.131022] Starting dynamic subtest: pipe-D
[345.263536] Dynamic subtest pipe-D: SUCCESS (1.145s)
[345.265868] Subtest plane-scaler-with-clipping-clamping-pixel-formats: SUCCESS (3.540s)
[346.465367] [080/133] (673s left) kms_pipe_crc_basic (hang-read-crc)
[346.575171] Starting subtest: hang-read-crc
[346.577485] Starting dynamic subtest: pipe-A-eDP-1
[348.620191] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.049s)
[348.630062] Starting dynamic subtest: pipe-B-eDP-1
[351.381979] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.767s)
[351.391968] Starting dynamic subtest: pipe-C-eDP-1
[354.004221] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.622s)
[354.015241] Starting dynamic subtest: pipe-D-eDP-1
[356.684111] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.678s)
[356.686582] Subtest hang-read-crc: SUCCESS (10.122s)
[357.560415] [081/133] (662s left) kms_selftest (drm_format)
[357.619641] Starting subtest: drm_format
[357.631004] Starting dynamic subtest: drm_test_format_block_width_invalid
[357.762072] Dynamic subtest drm_test_format_block_width_invalid: SUCCESS (0.129s)
[357.773518] Starting dynamic subtest: drm_test_format_block_width_one_plane
[357.861573] Dynamic subtest drm_test_format_block_width_one_plane: SUCCESS (0.100s)
[357.872860] Starting dynamic subtest: drm_test_format_block_width_two_plane
[358.000942] Dynamic subtest drm_test_format_block_width_two_plane: SUCCESS (0.139s)
[358.012042] Starting dynamic subtest: drm_test_format_block_width_three_plane
[358.147238] Dynamic subtest drm_test_format_block_width_three_plane: SUCCESS (0.145s)
[358.156803] Starting dynamic subtest: drm_test_format_block_width_tiled
[358.275816] Dynamic subtest drm_test_format_block_width_tiled: SUCCESS (0.125s)
[358.285984] Starting dynamic subtest: drm_test_format_block_height_invalid
[358.364953] Dynamic subtest drm_test_format_block_height_invalid: SUCCESS (0.090s)
[358.374555] Starting dynamic subtest: drm_test_format_block_height_one_plane
[358.486006] Dynamic subtest drm_test_format_block_height_one_plane: SUCCESS (0.120s)
[358.495209] Starting dynamic subtest: drm_test_format_block_height_two_plane
[358.614431] Dynamic subtest drm_test_format_block_height_two_plane: SUCCESS (0.124s)
[358.624846] Starting dynamic subtest: drm_test_format_block_height_three_plane
[358.710628] Dynamic subtest drm_test_format_block_height_three_plane: SUCCESS (0.096s)
[358.721788] Starting dynamic subtest: drm_test_format_block_height_tiled
[358.840186] Dynamic subtest drm_test_format_block_height_tiled: SUCCESS (0.126s)
[358.851103] Starting dynamic subtest: drm_test_format_min_pitch_invalid
[358.980023] Dynamic subtest drm_test_format_min_pitch_invalid: SUCCESS (0.139s)
[358.989970] Starting dynamic subtest: drm_test_format_min_pitch_one_plane_8bpp
[359.092287] Dynamic subtest drm_test_format_min_pitch_one_plane_8bpp: SUCCESS (0.112s)
[359.102061] Starting dynamic subtest: drm_test_format_min_pitch_one_plane_16bpp
[359.228400] Dynamic subtest drm_test_format_min_pitch_one_plane_16bpp: SUCCESS (0.135s)
[359.237584] Starting dynamic subtest: drm_test_format_min_pitch_one_plane_24bpp
[359.349043] Dynamic subtest drm_test_format_min_pitch_one_plane_24bpp: SUCCESS (0.119s)
[359.358445] Starting dynamic subtest: drm_test_format_min_pitch_one_plane_32bpp
[359.503884] Dynamic subtest drm_test_format_min_pitch_one_plane_32bpp: SUCCESS (0.154s)
[359.514316] Starting dynamic subtest: drm_test_format_min_pitch_two_plane
[359.647156] Dynamic subtest drm_test_format_min_pitch_two_plane: SUCCESS (0.141s)
[359.657056] Starting dynamic subtest: drm_test_format_min_pitch_three_plane_8bpp
[359.797047] Dynamic subtest drm_test_format_min_pitch_three_plane_8bpp: SUCCESS (0.148s)
[359.816433] Starting dynamic subtest: drm_test_format_min_pitch_tiled
[359.935034] Dynamic subtest drm_test_format_min_pitch_tiled: SUCCESS (0.136s)
[359.937413] Subtest drm_format: SUCCESS (2.310s)
[360.150371] [082/133] (660s left) gem_close_race (multigpu-basic-process)
[360.220797] Starting subtest: multigpu-basic-process
[360.225235] Subtest multigpu-basic-process: SKIP (0.000s)
[360.496783] [083/133] (660s left) gem_set_tiling_vs_gtt
[360.629265] [084/133] (659s left) kms_plane_scaling (planes-downscale-factor-0-5-unity-scaling)
[360.739883] Starting subtest: planes-downscale-factor-0-5-unity-scaling
[360.742170] Starting dynamic subtest: pipe-A
[360.763732] Dynamic subtest pipe-A: SKIP (0.018s)
[360.780336] Starting dynamic subtest: pipe-B
[360.793807] Dynamic subtest pipe-B: SKIP (0.031s)
[360.804155] Starting dynamic subtest: pipe-C
[360.826358] Dynamic subtest pipe-C: SKIP (0.030s)
[360.836136] Starting dynamic subtest: pipe-D
[360.856009] Dynamic subtest pipe-D: SKIP (0.030s)
[360.859635] Subtest planes-downscale-factor-0-5-unity-scaling: SKIP (0.114s)
[360.989732] [085/133] (659s left) kms_addfb_basic (basic-y-tiled-legacy)
[361.053966] Starting subtest: basic-y-tiled-legacy
[361.058470] Subtest basic-y-tiled-legacy: SKIP (0.000s)
[361.196345] [086/133] (659s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-0)
[361.306534] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-0
[362.330370] Subtest x-tiled-max-hw-stride-32bpp-rotate-0: SUCCESS (1.023s)
[362.480342] [087/133] (658s left) gem_render_copy (y-tiled-mc-ccs-to-yf-tiled-ccs)
[362.539776] Starting subtest: y-tiled-mc-ccs-to-yf-tiled-ccs
[362.543458] Subtest y-tiled-mc-ccs-to-yf-tiled-ccs: SKIP (0.000s)
[362.737186] [088/133] (658s left) gem_caching (writes)
[362.810179] Subtest writes: SKIP (0.000s)
[362.901433] [089/133] (657s left) syncobj_timeline (etime-multi-wait-for-submit-unsubmitted)
[362.962111] Starting subtest: etime-multi-wait-for-submit-unsubmitted
[363.070195] Subtest etime-multi-wait-for-submit-unsubmitted: SUCCESS (0.108s)
[363.162322] [090/133] (657s left) kms_flip (wf_vblank-ts-check)
[363.262478] Starting subtest: wf_vblank-ts-check
[363.264782] Starting dynamic subtest: A-eDP1
[372.173016] Dynamic subtest A-eDP1: SUCCESS (8.909s)
[372.182323] Starting dynamic subtest: B-eDP1
[381.108030] Dynamic subtest B-eDP1: SUCCESS (8.934s)
[381.122485] Starting dynamic subtest: C-eDP1
[390.028481] Dynamic subtest C-eDP1: SUCCESS (8.920s)
[390.038553] Starting dynamic subtest: D-eDP1
[398.972615] Dynamic subtest D-eDP1: SUCCESS (8.936s)
[398.974704] Subtest wf_vblank-ts-check: SUCCESS (35.710s)
[400.206361] [091/133] (620s left) gem_lmem_evict (dontneed-evict-race)
[400.250662] Subtest dontneed-evict-race: SKIP (0.000s)
[400.305459] [092/133] (620s left) gem_mmap_gtt (medium-copy-odd)
[400.367167] Subtest medium-copy-odd: SKIP (0.000s)
[400.438955] [093/133] (620s left) kms_plane (pixel-format-4-tiled-dg2-mc-ccs-modifier)
[400.547114] Starting subtest: pixel-format-4-tiled-dg2-mc-ccs-modifier
[400.559986] Subtest pixel-format-4-tiled-dg2-mc-ccs-modifier: SKIP (0.000s)
[400.635088] [094/133] (620s left) kms_ccs (crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc)
[400.739024] Starting subtest: crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc
[400.741134] Starting dynamic subtest: pipe-A-eDP-1
[400.796984] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[400.807836] Starting dynamic subtest: pipe-B-eDP-1
[400.864375] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[400.875139] Starting dynamic subtest: pipe-C-eDP-1
[400.931751] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[400.941832] Starting dynamic subtest: pipe-D-eDP-1
[400.998597] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[401.002686] Subtest crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc: SKIP (0.009s)
[402.975670] [095/133] (618s left) gem_exec_suspend (basic-s0)
[403.050771] Starting subtest: basic-S0
[403.052987] Starting dynamic subtest: smem
[423.949783] Dynamic subtest smem: SUCCESS (6.921s)
[423.952730] Subtest basic-S0: SUCCESS (6.924s)
[424.146771] [096/133] (596s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-180)
[424.262767] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-180
[425.244809] Subtest 4-tiled-max-hw-stride-64bpp-rotate-180: SUCCESS (1.011s)
[425.398771] [097/133] (595s left) gem_mmap_offset (bad-extensions)
[425.461196] Starting subtest: bad-extensions
[425.463443] Subtest bad-extensions: SUCCESS (0.000s)
[425.583139] [098/133] (595s left) kms_cursor_legacy (2x-long-nonblocking-modeset-vs-cursor-atomic)
[425.688334] Starting subtest: 2x-long-nonblocking-modeset-vs-cursor-atomic
[425.692694] Subtest 2x-long-nonblocking-modeset-vs-cursor-atomic: SKIP (0.001s)
[425.840743] [099/133] (595s left) gem_mmap_gtt (cpuset-big-copy-odd)
[425.894902] Subtest cpuset-big-copy-odd: SKIP (0.000s)
[425.950936] [100/133] (595s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-180-async-flip)
[426.052782] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-180-async-flip
[426.058053] Subtest yf-tiled-max-hw-stride-64bpp-rotate-180-async-flip: SKIP (0.000s)
[426.173154] [101/133] (595s left) kms_psr (fbc-psr2-sprite-render)
[426.260564] Starting subtest: fbc-psr2-sprite-render
[426.262782] Starting dynamic subtest: eDP-1
[426.267031] Dynamic subtest eDP-1: SKIP (0.000s)
[426.270910] Subtest fbc-psr2-sprite-render: SKIP (0.001s)
[426.347377] [102/133] (595s left) kms_frontbuffer_tracking (fbcpsr-1p-shrfb-fliptrack-mmap-gtt)
[426.438070] Starting subtest: fbcpsr-1p-shrfb-fliptrack-mmap-gtt
[426.441448] Subtest fbcpsr-1p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s)
[426.564674] [103/133] (594s left) kms_ccs (crc-primary-basic-y-tiled-ccs)
[426.652197] Starting subtest: crc-primary-basic-y-tiled-ccs
[426.654138] Starting dynamic subtest: pipe-A-eDP-1
[426.676311] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[426.687167] Starting dynamic subtest: pipe-B-eDP-1
[426.708567] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[426.717266] Starting dynamic subtest: pipe-C-eDP-1
[426.739110] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[426.747653] Starting dynamic subtest: pipe-D-eDP-1
[426.766810] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[426.770321] Subtest crc-primary-basic-y-tiled-ccs: SKIP (0.006s)
[428.870240] [104/133] (592s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-pwrite)
[428.971479] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-pwrite
[428.976199] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[429.103304] [105/133] (592s left) api_intel_bb (add-remove-objects)
[429.166804] Starting subtest: add-remove-objects
[429.172499] Subtest add-remove-objects: SUCCESS (0.009s)
[429.317107] [106/133] (592s left) sysfs_heartbeat_interval (nopreempt)
[429.389507] Starting subtest: nopreempt
[429.392057] Starting dynamic subtest: vecs0
[438.943958] Dynamic subtest vecs0: SUCCESS (9.639s)
[438.956572] Starting dynamic subtest: ccs0
[443.026653] Dynamic subtest ccs0: SUCCESS (4.098s)
[443.036781] Starting dynamic subtest: vcs0
[452.967928] Dynamic subtest vcs0: SUCCESS (9.958s)
[452.980767] Starting dynamic subtest: bcs0
[456.941415] Dynamic subtest bcs0: SUCCESS (3.971s)
[456.953035] Starting dynamic subtest: rcs0
[461.017592] Dynamic subtest rcs0: SUCCESS (4.072s)
[461.027774] Starting dynamic subtest: vcs1
[470.930711] Dynamic subtest vcs1: SUCCESS (9.909s)
[470.933527] Subtest nopreempt: SUCCESS (41.659s)
[471.020900] [107/133] (550s left) kms_getfb (getfb2-into-addfb2)
[471.130482] Starting subtest: getfb2-into-addfb2
[471.133093] Subtest getfb2-into-addfb2: SUCCESS (0.000s)
[471.266588] [108/133] (550s left) gem_close (basic)
[471.326327] Starting subtest: basic
[471.328565] Subtest basic: SUCCESS (0.000s)
[471.446866] [109/133] (550s left) gem_exec_schedule (preemptive-hang)
[471.627319] Starting subtest: preemptive-hang
[471.629335] Starting dynamic subtest: rcs0
[481.079228] Dynamic subtest rcs0: SUCCESS (9.450s)
[481.090985] Starting dynamic subtest: bcs0
[490.037692] Dynamic subtest bcs0: SUCCESS (8.962s)
[490.049449] Starting dynamic subtest: vcs0
[499.061771] Dynamic subtest vcs0: SUCCESS (9.023s)
[499.074281] Starting dynamic subtest: vcs1
[508.023792] Dynamic subtest vcs1: SUCCESS (8.965s)
[508.033123] Starting dynamic subtest: vecs0
[517.042766] Dynamic subtest vecs0: SUCCESS (9.017s)
[517.053773] Starting dynamic subtest: ccs0
[526.071504] Dynamic subtest ccs0: SUCCESS (9.029s)
[526.074251] Subtest preemptive-hang: SUCCESS (54.454s)
[526.337056] [110/133] (495s left) i915_drm_fdinfo (virtual-busy-idle)
[526.382224] Starting subtest: virtual-busy-idle
[526.387772] Subtest virtual-busy-idle: SKIP (0.000s)
[526.459055] [111/133] (495s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-mmap-wc)
[526.572810] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-mmap-wc
[530.527292] Subtest fbc-1p-offscreen-pri-indfb-draw-mmap-wc: SUCCESS (3.957s)
[531.746331] [112/133] (490s left) gem_linear_blits (interruptible)
[531.943599] Starting subtest: interruptible
[536.607243] Subtest interruptible: SUCCESS (4.662s)
[536.779406] [113/133] (485s left) gem_ctx_persistence (engines-mixed)
[536.892797] Starting subtest: engines-mixed
[536.895810] Starting dynamic subtest: rcs0
[536.995653] Dynamic subtest rcs0: SUCCESS (0.103s)
[537.008868] Starting dynamic subtest: bcs0
[537.079982] Dynamic subtest bcs0: SUCCESS (0.081s)
[537.092694] Starting dynamic subtest: vcs0
[537.143173] Dynamic subtest vcs0: SUCCESS (0.061s)
[537.155709] Starting dynamic subtest: vcs1
[537.225087] Dynamic subtest vcs1: SUCCESS (0.080s)
[537.237691] Starting dynamic subtest: vecs0
[537.313072] Dynamic subtest vecs0: SUCCESS (0.086s)
[537.326329] Starting dynamic subtest: ccs0
[537.393986] Dynamic subtest ccs0: SUCCESS (0.079s)
[537.396727] Subtest engines-mixed: SUCCESS (0.502s)
[537.494144] [114/133] (484s left) perf_pmu (init-wait)
[537.537530] Starting subtest: init-wait
[537.539697] Starting dynamic subtest: rcs0
[537.542243] Dynamic subtest rcs0: SUCCESS (0.003s)
[537.552790] Starting dynamic subtest: bcs0
[537.555408] Dynamic subtest bcs0: SUCCESS (0.001s)
[537.564679] Starting dynamic subtest: vcs0
[537.567551] Dynamic subtest vcs0: SUCCESS (0.001s)
[537.577222] Starting dynamic subtest: vcs1
[537.579573] Dynamic subtest vcs1: SUCCESS (0.001s)
[537.589375] Starting dynamic subtest: vecs0
[537.591466] Dynamic subtest vecs0: SUCCESS (0.001s)
[537.601592] Starting dynamic subtest: ccs0
[537.604541] Dynamic subtest ccs0: SUCCESS (0.001s)
[537.607572] Subtest init-wait: SUCCESS (0.010s)
[537.687373] [115/133] (484s left) gem_exec_reloc (basic-gtt-cpu-active)
[537.754607] Subtest basic-gtt-cpu-active: SKIP (0.000s)
[537.840957] [116/133] (484s left) kms_pm_lpsp (screens-disabled)
[538.958060] Starting subtest: screens-disabled
[538.963215] Subtest screens-disabled: SKIP (0.000s)
[539.039570] [117/133] (482s left) kms_flip (flip-vs-expired-vblank-interruptible)
[539.148619] Starting subtest: flip-vs-expired-vblank-interruptible
[539.151563] Starting dynamic subtest: A-eDP1
[547.820453] Dynamic subtest A-eDP1: SUCCESS (8.670s)
[547.830645] Starting dynamic subtest: B-eDP1
[556.452698] Dynamic subtest B-eDP1: SUCCESS (8.631s)
[556.463837] Starting dynamic subtest: C-eDP1
[565.088313] Dynamic subtest C-eDP1: SUCCESS (8.634s)
[565.098369] Starting dynamic subtest: D-eDP1
[573.722249] Dynamic subtest D-eDP1: SUCCESS (8.633s)
[573.724910] Subtest flip-vs-expired-vblank-interruptible: SUCCESS (34.577s)
[574.901677] [118/133] (447s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-move)
[575.016553] Starting subtest: psr-1p-primscrn-cur-indfb-move
[582.360814] Subtest psr-1p-primscrn-cur-indfb-move: SUCCESS (7.350s)
[582.543123] [119/133] (439s left) kms_atomic_transition (plane-all-modeset-transition-internal-panels)
[582.649197] Starting subtest: plane-all-modeset-transition-internal-panels
[582.651452] Starting dynamic subtest: pipe-A-eDP-1
[583.956853] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.308s)
[584.239772] Starting dynamic subtest: pipe-B-eDP-1
[585.279108] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.048s)
[585.563579] Subtest plane-all-modeset-transition-internal-panels: SUCCESS (2.917s)
[586.403231] [120/133] (435s left) gem_userptr_blits (stress-mm)
[586.474485] Starting subtest: stress-mm
[591.843245] Subtest stress-mm: SUCCESS (5.369s)
[592.010561] [121/133] (430s left) syncobj_eventfd (invalid-bad-flags)
[592.070708] Starting subtest: invalid-bad-flags
[592.073648] Subtest invalid-bad-flags: SUCCESS (0.000s)
[592.206666] [122/133] (430s left) kms_addfb_basic (framebuffer-vs-set-tiling)
[592.273681] Starting subtest: framebuffer-vs-set-tiling
[592.278626] Subtest framebuffer-vs-set-tiling: SKIP (0.000s)
[592.444755] [123/133] (429s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-indfb-msflip-blt)
[592.550822] Starting subtest: fbc-2p-scndscrn-indfb-msflip-blt
[592.555791] Subtest fbc-2p-scndscrn-indfb-msflip-blt: SKIP (0.000s)
[592.678546] [124/133] (429s left) syncobj_timeline (multi-wait-for-submit-available-submitted-signaled)
[592.747579] Starting subtest: multi-wait-for-submit-available-submitted-signaled
[592.750274] Subtest multi-wait-for-submit-available-submitted-signaled: SUCCESS (0.000s)
[592.857398] [125/133] (429s left) kms_flip (2x-modeset-vs-vblank-race)
[592.947108] Starting subtest: 2x-modeset-vs-vblank-race
[592.956516] Subtest 2x-modeset-vs-vblank-race: SKIP (0.011s)
[593.085566] [126/133] (429s left) i915_query (query-regions-garbage-items)
[593.137553] Starting subtest: query-regions-garbage-items
[593.140124] Subtest query-regions-garbage-items: SUCCESS (0.000s)
[593.258629] [127/133] (429s left) kms_psr_stress_test (flip-primary-invalidate-overlay)
[593.342468] Starting subtest: flip-primary-invalidate-overlay
[605.059633] Subtest flip-primary-invalidate-overlay: SUCCESS (11.721s)
[605.243346] [128/133] (417s left) gem_exec_balancer (full-late)
[605.317282] Starting subtest: full-late
[609.818363] Subtest full-late: SUCCESS (4.502s)
[610.186258] [129/133] (412s left) gem_exec_reloc (basic-write-wc)
[610.253820] Subtest basic-write-wc: SKIP (0.000s)
[610.356182] [130/133] (412s left) kms_force_connector_basic (force-load-detect)
[610.443394] Starting subtest: force-load-detect
[610.448488] Subtest force-load-detect: SKIP (0.000s)
[610.572504] [131/133] (412s left) kms_chamelium_hpd (hdmi-hpd-fast)
[610.956811] Subtest hdmi-hpd-fast: SKIP (0.000s)
[611.802050] [132/133] (410s left) kms_flip_scaled_crc (flip-64bpp-xtile-to-32bpp-xtile-upscaling)
[611.901213] Starting subtest: flip-64bpp-xtile-to-32bpp-xtile-upscaling
[611.903500] Starting dynamic subtest: pipe-A-default-mode
[614.685000] Dynamic subtest pipe-A-default-mode: SUCCESS (2.784s)
[614.687705] Subtest flip-64bpp-xtile-to-32bpp-xtile-upscaling: SUCCESS (2.786s)
[615.532687] [133/133] (407s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-mmap-cpu)
[615.642943] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-mmap-cpu
[615.648595] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[615.759692] 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.