[56.178534] Initializing watchdogs
[56.178641]   /dev/watchdog0
[56.195293] [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.200068] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[56.202296] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[56.205741] [001/154] (960s left) kms_color (ctm-0-75)
[56.332248] Starting subtest: ctm-0-75
[56.334444] Starting dynamic subtest: pipe-A-eDP-1
[61.617413] Dynamic subtest pipe-A-eDP-1: SUCCESS (5.287s)
[61.625693] Starting dynamic subtest: pipe-B-eDP-1
[67.343738] Dynamic subtest pipe-B-eDP-1: SUCCESS (5.723s)
[67.351340] Starting dynamic subtest: pipe-C-eDP-1
[72.758765] Dynamic subtest pipe-C-eDP-1: SUCCESS (5.414s)
[72.768138] Starting dynamic subtest: pipe-D-eDP-1
[78.077169] Dynamic subtest pipe-D-eDP-1: SUCCESS (5.317s)
[78.079994] Subtest ctm-0-75: SUCCESS (21.744s)
[78.886566] [002/154] (937s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-indfb-msflip-blt)
[79.014015] Starting subtest: fbcpsr-2p-primscrn-indfb-msflip-blt
[79.018214] Subtest fbcpsr-2p-primscrn-indfb-msflip-blt: SKIP (0.000s)
[79.119220] [003/154] (937s left) gen9_exec_parse (basic-rejected)
[79.186351] Subtest basic-rejected: SKIP (0.000s)
[79.250448] [004/154] (937s left) fbdev (unaligned-read)
[79.297978] Starting subtest: unaligned-read
[79.313145] Subtest unaligned-read: SUCCESS (0.016s)
[79.364953] [005/154] (937s left) vgem_basic (debugfs)
[79.443223] Starting subtest: debugfs
[79.445501] Subtest debugfs: SUCCESS (0.000s)
[79.496502] [FACT vgem_basic (debugfs)] new: kernel.kmod_is_loaded.vgem: true
[79.499707] [006/154] (937s left) kms_getfb (getfb-handle-not-fb)
[79.586761] Starting subtest: getfb-handle-not-fb
[79.589053] Subtest getfb-handle-not-fb: SUCCESS (0.000s)
[79.685765] [007/154] (937s left) kms_psr2_sf (fbc-psr2-primary-plane-update-sf-dmg-area)
[79.783240] Starting subtest: fbc-psr2-primary-plane-update-sf-dmg-area
[79.785649] Starting dynamic subtest: pipe-A-eDP-1
[79.882458] Dynamic subtest pipe-A-eDP-1: SKIP (0.101s)
[79.894839] Starting dynamic subtest: pipe-B-eDP-1
[81.071849] Dynamic subtest pipe-B-eDP-1: SKIP (1.185s)
[81.076637] Subtest fbc-psr2-primary-plane-update-sf-dmg-area: SKIP (1.291s)
[82.257517] [008/154] (934s left) kms_cursor_crc (cursor-onscreen-256x85)
[82.510815] Starting subtest: cursor-onscreen-256x85
[82.560057] Subtest cursor-onscreen-256x85: SKIP (0.045s)
[82.730664] [009/154] (934s left) kms_psr2_sf (fbc-pr-overlay-plane-move-continuous-exceed-fully-sf)
[82.821253] Starting subtest: fbc-pr-overlay-plane-move-continuous-exceed-fully-sf
[82.825483] Subtest fbc-pr-overlay-plane-move-continuous-exceed-fully-sf: SKIP (0.000s)
[82.901469] [010/154] (934s left) gem_ppgtt (blt-vs-render-ctx0)
[82.953724] Starting subtest: blt-vs-render-ctx0
[115.784195] Subtest blt-vs-render-ctx0: SUCCESS (32.828s)
[115.924809] [011/154] (901s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-indfb-fliptrack-mmap-gtt)
[116.071632] Starting subtest: fbcpsrhdr-1p-indfb-fliptrack-mmap-gtt
[116.076032] Subtest fbcpsrhdr-1p-indfb-fliptrack-mmap-gtt: SKIP (0.000s)
[116.179653] [012/154] (900s left) perf (rc6-disable)
[116.335908] Starting subtest: rc6-disable
[116.508985] Subtest rc6-disable: SUCCESS (0.174s)
[116.562275] [013/154] (900s left) gem_userptr_blits (nohangcheck)
[116.628458] Starting subtest: nohangcheck
[116.873757] Subtest nohangcheck: SUCCESS (0.245s)
[116.991361] [014/154] (900s left) kms_flip (2x-flip-vs-panning-interruptible)
[117.087447] Starting subtest: 2x-flip-vs-panning-interruptible
[117.100586] Subtest 2x-flip-vs-panning-interruptible: SKIP (0.011s)
[117.202673] [015/154] (900s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-mmap-gtt)
[117.298532] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-mmap-gtt
[117.302973] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[117.407473] [016/154] (899s left) gem_close_race (basic-threads)
[117.471987] Starting subtest: basic-threads
[118.804027] Subtest basic-threads: SUCCESS (1.334s)
[119.001511] [017/154] (898s left) kms_cursor_legacy (cursorb-vs-flipb-toggle)
[119.115323] Starting subtest: cursorB-vs-flipB-toggle
[119.119815] Subtest cursorB-vs-flipB-toggle: SKIP (0.001s)
[119.258292] [018/154] (898s left) kms_frontbuffer_tracking (psrhdr-2p-scndscrn-pri-shrfb-draw-pwrite)
[119.369608] Starting subtest: psrhdr-2p-scndscrn-pri-shrfb-draw-pwrite
[119.374041] Subtest psrhdr-2p-scndscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[119.466824] [019/154] (897s left) gem_eio (wait-10ms)
[119.700830] Starting subtest: wait-10ms
[120.068400] Subtest wait-10ms: SUCCESS (0.369s)
[120.240266] [020/154] (897s left) gem_exec_flush (basic-uc-set-default)
[120.298684] Starting subtest: basic-uc-set-default
[125.772691] Subtest basic-uc-set-default: SUCCESS (5.474s)
[125.961730] [021/154] (891s left) kms_plane (pixel-format-y-tiled-gen12-mc-ccs-modifier-source-clamping)
[126.068740] Starting subtest: pixel-format-y-tiled-gen12-mc-ccs-modifier-source-clamping
[126.072742] Subtest pixel-format-y-tiled-gen12-mc-ccs-modifier-source-clamping: SKIP (0.000s)
[126.146199] [022/154] (891s left) kms_frontbuffer_tracking (psrhdr-1p-primscrn-cur-indfb-move)
[126.245291] Starting subtest: psrhdr-1p-primscrn-cur-indfb-move
[126.249771] Subtest psrhdr-1p-primscrn-cur-indfb-move: SKIP (0.000s)
[126.341901] [023/154] (891s left) syncobj_wait (wait-for-submit-snapshot)
[126.393679] Starting subtest: wait-for-submit-snapshot
[126.473681] Subtest wait-for-submit-snapshot: SUCCESS (0.082s)
[126.549218] [024/154] (891s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-mmap-wc)
[126.653243] Starting subtest: fbc-rgb101010-draw-mmap-wc
[129.169307] Subtest fbc-rgb101010-draw-mmap-wc: SUCCESS (2.521s)
[130.372452] [025/154] (887s left) kms_ccs (ccs-on-another-bo-y-tiled-gen12-rc-ccs)
[130.471748] Starting subtest: ccs-on-another-bo-y-tiled-gen12-rc-ccs
[130.474120] Starting dynamic subtest: pipe-A-eDP-1
[130.496973] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[130.508203] Starting dynamic subtest: pipe-B-eDP-1
[130.529402] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[130.538208] Starting dynamic subtest: pipe-C-eDP-1
[130.560584] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[130.570915] Starting dynamic subtest: pipe-D-eDP-1
[130.592882] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[130.597219] Subtest ccs-on-another-bo-y-tiled-gen12-rc-ccs: SKIP (0.004s)
[132.728381] [026/154] (884s left) i915_pm_rps (thresholds-idle)
[132.792888] Starting subtest: thresholds-idle
[132.797575] Subtest thresholds-idle: SKIP (0.001s)
[132.891258] [027/154] (884s left) syncobj_wait (multi-wait-all-for-submit-signaled)
[132.950067] Starting subtest: multi-wait-all-for-submit-signaled
[132.952319] Subtest multi-wait-all-for-submit-signaled: SUCCESS (0.001s)
[133.066555] [028/154] (884s left) syncobj_basic (test-valid-cycle)
[133.113921] Starting subtest: test-valid-cycle
[133.116218] Subtest test-valid-cycle: SUCCESS (0.000s)
[133.211983] [029/154] (884s left) kms_cursor_legacy (flip-vs-cursor-legacy)
[133.335866] Starting subtest: flip-vs-cursor-legacy
[140.814673] Subtest flip-vs-cursor-legacy: SUCCESS (7.480s)
[141.670160] [030/154] (876s left) syncobj_eventfd (invalid-illegal-eventfd)
[141.738380] Starting subtest: invalid-illegal-eventfd
[141.740932] Subtest invalid-illegal-eventfd: SUCCESS (0.000s)
[141.836799] [031/154] (876s left) prime_vgem (busy)
[141.922717] Starting subtest: busy
[141.925201] Starting dynamic subtest: rcs0
[141.990522] Dynamic subtest rcs0: SUCCESS (0.068s)
[142.000168] Starting dynamic subtest: bcs0
[142.066743] Dynamic subtest bcs0: SUCCESS (0.076s)
[142.077617] Starting dynamic subtest: vcs0
[142.114846] Dynamic subtest vcs0: SUCCESS (0.047s)
[142.125319] Starting dynamic subtest: vcs1
[142.164172] Dynamic subtest vcs1: SUCCESS (0.049s)
[142.173281] Starting dynamic subtest: vecs0
[142.211173] Dynamic subtest vecs0: SUCCESS (0.046s)
[142.220269] Starting dynamic subtest: ccs0
[142.257810] Dynamic subtest ccs0: SUCCESS (0.046s)
[142.260171] Subtest busy: SUCCESS (0.336s)
[142.377846] [032/154] (875s left) api_intel_bb (reset-bb)
[142.447194] Starting subtest: reset-bb
[142.452575] Subtest reset-bb: SUCCESS (0.004s)
[142.584394] [033/154] (875s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-indfb-plflip-blt)
[142.688858] Starting subtest: fbcpsr-2p-scndscrn-indfb-plflip-blt
[142.692274] Subtest fbcpsr-2p-scndscrn-indfb-plflip-blt: SKIP (0.000s)
[142.810178] [034/154] (875s left) i915_pm_rpm (gem-mmap-type)
[144.537026] Starting subtest: gem-mmap-type
[144.539613] Starting dynamic subtest: wb-smem0
[147.927135] Dynamic subtest wb-smem0: SUCCESS (3.393s)
[147.938384] Starting dynamic subtest: wc-smem0
[151.126043] Dynamic subtest wc-smem0: SUCCESS (3.196s)
[151.136632] Starting dynamic subtest: uc-smem0
[154.317901] Dynamic subtest uc-smem0: SUCCESS (3.190s)
[154.320302] Subtest gem-mmap-type: SUCCESS (9.782s)
[154.436298] [035/154] (863s left) gem_exec_schedule (out-order)
[154.510834] Starting subtest: out-order
[154.513106] Starting dynamic subtest: rcs0
[154.604450] Dynamic subtest rcs0: SUCCESS (0.101s)
[154.616049] Starting dynamic subtest: vcs0
[154.694229] Dynamic subtest vcs0: SUCCESS (0.088s)
[154.704825] Starting dynamic subtest: vcs1
[154.779754] Dynamic subtest vcs1: SUCCESS (0.085s)
[154.792073] Starting dynamic subtest: vecs0
[154.857360] Dynamic subtest vecs0: SUCCESS (0.077s)
[154.871153] Starting dynamic subtest: ccs0
[154.962052] Dynamic subtest ccs0: SUCCESS (0.104s)
[154.964674] Subtest out-order: SUCCESS (0.459s)
[156.413324] [036/154] (861s left) gem_lmem_swapping (heavy-random)
[156.456211] Subtest heavy-random: SKIP (0.000s)
[156.500145] [037/154] (861s left) gem_spin_batch (resubmit-new-all)
[156.561488] Starting subtest: resubmit-new-all
[156.564681] Starting dynamic subtest: rcs0
[156.575353] Dynamic subtest rcs0: SUCCESS (0.014s)
[156.588889] Starting dynamic subtest: bcs0
[156.590766] Dynamic subtest bcs0: SUCCESS (0.008s)
[156.599862] Starting dynamic subtest: vcs0
[156.601952] Dynamic subtest vcs0: SUCCESS (0.009s)
[156.610933] Starting dynamic subtest: vcs1
[156.613431] Dynamic subtest vcs1: SUCCESS (0.008s)
[156.622471] Starting dynamic subtest: vecs0
[156.624730] Dynamic subtest vecs0: SUCCESS (0.010s)
[156.633712] Starting dynamic subtest: ccs0
[156.635941] Dynamic subtest ccs0: SUCCESS (0.009s)
[156.638143] Subtest resubmit-new-all: SUCCESS (0.061s)
[158.348108] [038/154] (859s left) kms_frontbuffer_tracking (hdr-shrfb-scaledprimary)
[158.447318] Starting subtest: hdr-shrfb-scaledprimary
[158.451461] Subtest hdr-shrfb-scaledprimary: SKIP (0.000s)
[158.568315] [039/154] (859s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-primscrn-cur-indfb-draw-mmap-cpu)
[158.662058] Starting subtest: fbcpsrhdr-1p-primscrn-cur-indfb-draw-mmap-cpu
[158.666399] Subtest fbcpsrhdr-1p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[158.777243] [040/154] (859s left) kms_big_fb (4-tiled-32bpp-rotate-270)
[158.877141] Starting subtest: 4-tiled-32bpp-rotate-270
[158.896521] Subtest 4-tiled-32bpp-rotate-270: SKIP (0.019s)
[158.997905] [041/154] (859s left) kms_frontbuffer_tracking (fbchdr-2p-scndscrn-spr-indfb-draw-mmap-wc)
[159.094756] Starting subtest: fbchdr-2p-scndscrn-spr-indfb-draw-mmap-wc
[159.099164] Subtest fbchdr-2p-scndscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[159.173190] [042/154] (859s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-primscrn-spr-indfb-draw-mmap-gtt)
[159.271796] Starting subtest: fbcpsrhdr-1p-primscrn-spr-indfb-draw-mmap-gtt
[159.275977] Subtest fbcpsrhdr-1p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[159.372492] [043/154] (859s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-0-async-flip)
[159.483264] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-0-async-flip
[160.330081] Subtest x-tiled-max-hw-stride-64bpp-rotate-0-async-flip: SUCCESS (0.848s)
[160.493376] [044/154] (857s left) gem_exec_gttfill (basic)
[160.563115] Starting subtest: basic
[163.061694] Subtest basic: SUCCESS (2.498s)
[163.248650] [045/154] (855s left) kms_pm_backlight (basic-brightness)
[163.384899] Starting subtest: basic-brightness
[163.465951] Starting dynamic subtest: eDP-1
[163.974486] Dynamic subtest eDP-1: SUCCESS (0.506s)
[163.976923] Subtest basic-brightness: SUCCESS (0.589s)
[164.800416] [046/154] (853s left) kms_pipe_stress (stress-xrgb8888-yftiled)
[164.899592] Starting subtest: stress-xrgb8888-yftiled
[164.903955] Subtest stress-xrgb8888-yftiled: SKIP (0.000s)
[164.973630] [047/154] (853s left) gem_exec_balancer (persistence)
[165.242396] Starting subtest: persistence
[166.177217] Subtest persistence: SUCCESS (0.934s)
[166.310094] [048/154] (852s left) gem_eio (in-flight-contexts-10ms)
[166.546107] Starting subtest: in-flight-contexts-10ms
[180.338026] Subtest in-flight-contexts-10ms: SUCCESS (13.792s)
[180.502453] [049/154] (838s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-mmap-cpu)
[180.604225] Starting subtest: psr-1p-primscrn-cur-indfb-draw-mmap-cpu
[187.178399] Subtest psr-1p-primscrn-cur-indfb-draw-mmap-cpu: SUCCESS (6.580s)
[187.287833] [050/154] (831s left) kms_dirtyfb (drrs-dirtyfb-ioctl)
[187.377521] Starting subtest: drrs-dirtyfb-ioctl
[187.390214] Subtest drrs-dirtyfb-ioctl: SKIP (0.001s)
[187.482123] [051/154] (831s left) kms_chamelium_color (ctm-limited-range)
[187.584569] Subtest ctm-limited-range: SKIP (0.000s)
[187.633717] [052/154] (831s left) kms_big_fb (x-tiled-32bpp-rotate-90)
[187.746602] Starting subtest: x-tiled-32bpp-rotate-90
[187.766453] Subtest x-tiled-32bpp-rotate-90: SKIP (0.019s)
[187.880681] [053/154] (830s left) kms_frontbuffer_tracking (psrhdr-rgb565-draw-pwrite)
[187.971568] Starting subtest: psrhdr-rgb565-draw-pwrite
[187.975681] Subtest psrhdr-rgb565-draw-pwrite: SKIP (0.000s)
[188.084757] [054/154] (830s left) gem_render_copy (mixed-tiled-to-y-tiled-ccs)
[188.136740] Starting subtest: mixed-tiled-to-y-tiled-ccs
[188.140540] Subtest mixed-tiled-to-y-tiled-ccs: SKIP (0.000s)
[188.317413] [055/154] (830s left) kms_ccs (crc-primary-suspend-4-tiled-lnl-ccs)
[188.406798] Starting subtest: crc-primary-suspend-4-tiled-lnl-ccs
[188.411337] Subtest crc-primary-suspend-4-tiled-lnl-ccs: SKIP (0.000s)
[189.564049] [056/154] (829s left) kms_frontbuffer_tracking (fbchdr-2p-primscrn-pri-indfb-draw-render)
[189.666766] Starting subtest: fbchdr-2p-primscrn-pri-indfb-draw-render
[189.670748] Subtest fbchdr-2p-primscrn-pri-indfb-draw-render: SKIP (0.000s)
[189.747610] [057/154] (829s left) kms_frontbuffer_tracking (fbcpsr-modesetfrombusy)
[189.849810] Starting subtest: fbcpsr-modesetfrombusy
[196.140882] Subtest fbcpsr-modesetfrombusy: SUCCESS (6.297s)
[196.282756] [058/154] (822s left) kms_psr (psr-no-drrs)
[196.380920] Starting subtest: psr-no-drrs
[196.382697] Starting dynamic subtest: eDP-1
[197.998060] Dynamic subtest eDP-1: SUCCESS (1.616s)
[198.000391] Subtest psr-no-drrs: SUCCESS (1.617s)
[198.878249] [059/154] (820s left) kms_atomic (plane-cursor-legacy)
[198.984076] Starting subtest: plane-cursor-legacy
[198.986397] Starting dynamic subtest: pipe-A-eDP-1
[199.352528] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.367s)
[199.354717] Subtest plane-cursor-legacy: SUCCESS (0.369s)
[200.222334] [060/154] (818s left) gem_exec_fence (syncobj-repeat)
[200.672278] Starting subtest: syncobj-repeat
[200.865104] Subtest syncobj-repeat: SUCCESS (0.191s)
[202.412227] [061/154] (816s left) kms_frontbuffer_tracking (psr-2p-scndscrn-shrfb-pgflip-blt)
[202.501575] Starting subtest: psr-2p-scndscrn-shrfb-pgflip-blt
[202.505655] Subtest psr-2p-scndscrn-shrfb-pgflip-blt: SKIP (0.000s)
[202.593239] [062/154] (816s left) syncobj_timeline (single-wait-available-submitted)
[202.655220] Starting subtest: single-wait-available-submitted
[202.657517] Subtest single-wait-available-submitted: SUCCESS (0.000s)
[202.763114] [063/154] (816s left) kms_frontbuffer_tracking (psr-1p-primscrn-shrfb-msflip-blt)
[202.862196] Starting subtest: psr-1p-primscrn-shrfb-msflip-blt
[210.347036] Subtest psr-1p-primscrn-shrfb-msflip-blt: SUCCESS (7.489s)
[210.472826] [064/154] (808s left) gem_mmap_gtt (basic-write-read)
[210.525146] Subtest basic-write-read: SKIP (0.000s)
[210.581331] [065/154] (808s left) syncobj_timeline (invalid-signal-zero-handles)
[210.629731] Starting subtest: invalid-signal-zero-handles
[210.632069] Subtest invalid-signal-zero-handles: SUCCESS (0.000s)
[210.736211] [066/154] (808s left) kms_frontbuffer_tracking (fbc-rgb565-draw-mmap-gtt)
[210.836600] Starting subtest: fbc-rgb565-draw-mmap-gtt
[210.841076] Subtest fbc-rgb565-draw-mmap-gtt: SKIP (0.000s)
[210.920754] [067/154] (808s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-mmap-wc)
[211.012851] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-mmap-wc
[211.017470] Subtest fbc-2p-scndscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[211.125466] [068/154] (808s left) gem_exec_params (invalid-bsd2-flag-on-blt)
[211.192307] Starting subtest: invalid-bsd2-flag-on-blt
[211.194594] Subtest invalid-bsd2-flag-on-blt: SUCCESS (0.000s)
[211.293625] [069/154] (808s left) gem_exec_params (secure-non-master)
[211.367649] Starting subtest: secure-non-master
[211.371320] Subtest secure-non-master: SKIP (0.000s)
[211.483474] [070/154] (808s left) kms_async_flips (async-flip-with-page-flip-events-linear-atomic)
[211.568203] Starting subtest: async-flip-with-page-flip-events-linear-atomic
[211.955423] Starting dynamic subtest: pipe-A-eDP-1
[214.739781] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.784s)
[215.104586] Starting dynamic subtest: pipe-B-eDP-1
[217.869977] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.771s)
[218.255373] Starting dynamic subtest: pipe-C-eDP-1
[221.005367] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.759s)
[221.374273] Starting dynamic subtest: pipe-D-eDP-1
[224.145037] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.779s)
[224.147737] Subtest async-flip-with-page-flip-events-linear-atomic: SUCCESS (12.577s)
[225.341244] [071/154] (794s left) kms_frontbuffer_tracking (psrhdr-2p-scndscrn-shrfb-plflip-blt)
[225.438352] Starting subtest: psrhdr-2p-scndscrn-shrfb-plflip-blt
[225.442369] Subtest psrhdr-2p-scndscrn-shrfb-plflip-blt: SKIP (0.000s)
[225.542297] [072/154] (794s left) kms_joiner (basic-force-big-joiner)
[225.642550] Starting subtest: basic-force-big-joiner
[225.646672] Subtest basic-force-big-joiner: SKIP (0.000s)
[225.710176] [073/154] (793s left) gem_exec_reloc (basic-gtt-read-active)
[225.768050] Subtest basic-gtt-read-active: SKIP (0.000s)
[225.838121] [074/154] (793s left) kms_frontbuffer_tracking (fbchdr-1p-primscrn-pri-indfb-draw-mmap-cpu)
[225.930977] Starting subtest: fbchdr-1p-primscrn-pri-indfb-draw-mmap-cpu
[225.935058] Subtest fbchdr-1p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[226.021065] [075/154] (793s left) kms_frontbuffer_tracking (hdr-2p-scndscrn-spr-indfb-draw-pwrite)
[226.123273] Starting subtest: hdr-2p-scndscrn-spr-indfb-draw-pwrite
[226.127428] Subtest hdr-2p-scndscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[226.215110] [076/154] (793s left) kms_draw_crc (draw-method-pwrite)
[226.318103] Starting subtest: draw-method-pwrite
[226.319943] Starting dynamic subtest: xrgb8888-untiled
[226.928555] Dynamic subtest xrgb8888-untiled: SUCCESS (0.610s)
[226.939223] Starting dynamic subtest: rgb565-untiled
[227.396114] Dynamic subtest rgb565-untiled: SUCCESS (0.467s)
[227.406331] Starting dynamic subtest: xrgb2101010-untiled
[227.961886] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.565s)
[227.972077] Starting dynamic subtest: xbgr16161616f-untiled
[228.762108] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.799s)
[228.772410] Starting dynamic subtest: xrgb8888-xtiled
[230.617348] Dynamic subtest xrgb8888-xtiled: SUCCESS (1.855s)
[230.627339] Starting dynamic subtest: rgb565-xtiled
[231.773640] Dynamic subtest rgb565-xtiled: SUCCESS (1.155s)
[231.784252] Starting dynamic subtest: xrgb2101010-xtiled
[233.628837] Dynamic subtest xrgb2101010-xtiled: SUCCESS (1.854s)
[233.639480] Starting dynamic subtest: xbgr16161616f-xtiled
[237.108098] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (3.477s)
[237.118061] Starting dynamic subtest: xrgb8888-4tiled
[238.262357] Dynamic subtest xrgb8888-4tiled: SUCCESS (1.155s)
[238.273109] Starting dynamic subtest: rgb565-4tiled
[238.851661] Dynamic subtest rgb565-4tiled: SUCCESS (0.588s)
[238.863568] Starting dynamic subtest: xrgb2101010-4tiled
[240.007060] Dynamic subtest xrgb2101010-4tiled: SUCCESS (1.155s)
[240.017274] Starting dynamic subtest: xbgr16161616f-4tiled
[243.151338] Dynamic subtest xbgr16161616f-4tiled: SUCCESS (3.143s)
[243.153627] Subtest draw-method-pwrite: SUCCESS (16.834s)
[243.258406] [077/154] (776s left) kms_plane_scaling (plane-scaler-unity-scaling-with-pixel-format)
[243.352641] Starting subtest: plane-scaler-unity-scaling-with-pixel-format
[243.355300] Starting dynamic subtest: pipe-A
[244.465868] Dynamic subtest pipe-A: SUCCESS (1.117s)
[244.475987] Starting dynamic subtest: pipe-B
[246.806659] Dynamic subtest pipe-B: SUCCESS (2.340s)
[246.819216] Starting dynamic subtest: pipe-C
[248.049893] Dynamic subtest pipe-C: SUCCESS (1.242s)
[248.059591] Starting dynamic subtest: pipe-D
[249.264048] Dynamic subtest pipe-D: SUCCESS (1.213s)
[249.266461] Subtest plane-scaler-unity-scaling-with-pixel-format: SUCCESS (5.916s)
[250.460061] [078/154] (769s left) kms_frontbuffer_tracking (fbchdr-1p-primscrn-spr-indfb-draw-render)
[250.558761] Starting subtest: fbchdr-1p-primscrn-spr-indfb-draw-render
[250.562744] Subtest fbchdr-1p-primscrn-spr-indfb-draw-render: SKIP (0.000s)
[250.671769] [079/154] (769s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-180-async-flip)
[250.774158] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-180-async-flip
[250.778620] Subtest yf-tiled-max-hw-stride-32bpp-rotate-180-async-flip: SKIP (0.000s)
[250.873987] [080/154] (769s left) gem_exec_schedule (u-semaphore-user)
[250.940649] Starting subtest: u-semaphore-user
[250.993493] Subtest u-semaphore-user: SUCCESS (0.059s)
[252.374259] [081/154] (767s left) api_intel_allocator (gem-pool)
[252.428189] Starting subtest: gem-pool
[252.433838] Subtest gem-pool: SUCCESS (0.008s)
[252.555361] [082/154] (767s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-primscrn-pri-indfb-draw-render)
[252.665635] Starting subtest: fbcpsrhdr-2p-primscrn-pri-indfb-draw-render
[252.669775] Subtest fbcpsrhdr-2p-primscrn-pri-indfb-draw-render: SKIP (0.000s)
[252.778528] [083/154] (767s left) kms_psr (fbc-pr-cursor-render)
[252.883440] Starting subtest: fbc-pr-cursor-render
[252.887455] Subtest fbc-pr-cursor-render: SKIP (0.000s)
[252.956085] [084/154] (767s left) kms_cursor_crc (cursor-tearing-position-change)
[253.055109] Starting subtest: cursor-tearing-position-change
[253.057490] Starting dynamic subtest: pipe-A-eDP-1
[253.644099] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.587s)
[253.654888] Starting dynamic subtest: pipe-D-eDP-1
[254.907554] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.262s)
[254.909996] Subtest cursor-tearing-position-change: SUCCESS (1.852s)
[255.740607] [085/154] (764s left) kms_frontbuffer_tracking (hdr-1p-primscrn-pri-shrfb-draw-render)
[255.843772] Starting subtest: hdr-1p-primscrn-pri-shrfb-draw-render
[255.848061] Subtest hdr-1p-primscrn-pri-shrfb-draw-render: SKIP (0.000s)
[255.967591] [086/154] (764s left) gem_render_copy (yf-tiled-to-vebox-linear)
[256.020585] Starting subtest: yf-tiled-to-vebox-linear
[256.025258] Subtest yf-tiled-to-vebox-linear: SKIP (0.000s)
[256.205832] [087/154] (764s left) kms_frontbuffer_tracking (fbchdr-rgb101010-draw-pwrite)
[256.302834] Starting subtest: fbchdr-rgb101010-draw-pwrite
[256.307251] Subtest fbchdr-rgb101010-draw-pwrite: SKIP (0.000s)
[256.410755] [088/154] (763s left) kms_ccs (bad-aux-stride-4-tiled-mtl-rc-ccs)
[256.492992] Starting subtest: bad-aux-stride-4-tiled-mtl-rc-ccs
[256.495359] Starting dynamic subtest: pipe-A-eDP-1
[256.515651] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.002s)
[256.526110] Starting dynamic subtest: pipe-B-eDP-1
[256.546434] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[256.555793] Starting dynamic subtest: pipe-C-eDP-1
[256.574183] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[256.583207] Starting dynamic subtest: pipe-D-eDP-1
[256.603163] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[256.604911] Subtest bad-aux-stride-4-tiled-mtl-rc-ccs: SUCCESS (0.009s)
[258.774536] [089/154] (761s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-scndscrn-pri-shrfb-draw-mmap-gtt)
[258.874174] Starting subtest: fbcpsrhdr-2p-scndscrn-pri-shrfb-draw-mmap-gtt
[258.878518] Subtest fbcpsrhdr-2p-scndscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[258.968472] [090/154] (761s left) kms_frontbuffer_tracking (fbcpsrhdr-rgb565-draw-mmap-cpu)
[259.064677] Starting subtest: fbcpsrhdr-rgb565-draw-mmap-cpu
[259.068942] Subtest fbcpsrhdr-rgb565-draw-mmap-cpu: SKIP (0.000s)
[259.178260] [091/154] (761s left) kms_ccs (bad-pixel-format-4-tiled-mtl-mc-ccs)
[259.259640] Starting subtest: bad-pixel-format-4-tiled-mtl-mc-ccs
[259.261783] Starting dynamic subtest: pipe-A-eDP-1
[259.281384] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[259.291714] Starting dynamic subtest: pipe-B-eDP-1
[259.310978] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[259.320192] Starting dynamic subtest: pipe-C-eDP-1
[259.340360] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[259.350210] Starting dynamic subtest: pipe-D-eDP-1
[259.369816] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[259.371754] Subtest bad-pixel-format-4-tiled-mtl-mc-ccs: SUCCESS (0.007s)
[261.521165] [092/154] (758s left) kms_frontbuffer_tracking (fbc-1p-primscrn-indfb-pgflip-blt)
[261.619698] Starting subtest: fbc-1p-primscrn-indfb-pgflip-blt
[266.118201] Subtest fbc-1p-primscrn-indfb-pgflip-blt: SUCCESS (4.505s)
[267.323574] [093/154] (753s left) kms_cursor_legacy (nonblocking-modeset-vs-cursor-atomic)
[267.443458] Starting subtest: nonblocking-modeset-vs-cursor-atomic
[268.904855] Subtest nonblocking-modeset-vs-cursor-atomic: SUCCESS (1.461s)
[269.786434] [094/154] (750s left) gem_exec_reloc (basic-write-cpu-active)
[269.858395] Subtest basic-write-cpu-active: SKIP (0.000s)
[269.934458] [095/154] (750s left) gem_exec_balancer (full-late-pulse)
[269.992864] Starting subtest: full-late-pulse
[275.213583] Subtest full-late-pulse: SUCCESS (5.220s)
[275.559168] [096/154] (745s left) gen9_exec_parse (valid-registers)
[275.614807] Subtest valid-registers: SKIP (0.000s)
[275.683722] [097/154] (745s left) kms_psr (fbc-psr2-primary-mmap-gtt)
[275.765964] Starting subtest: fbc-psr2-primary-mmap-gtt
[275.768265] Starting dynamic subtest: eDP-1
[275.772220] Dynamic subtest eDP-1: SKIP (0.000s)
[275.776244] Subtest fbc-psr2-primary-mmap-gtt: SKIP (0.001s)
[275.853805] [098/154] (744s left) perf_pmu (semaphore-wait)
[275.896052] Starting subtest: semaphore-wait
[275.897984] Starting dynamic subtest: rcs0
[276.408684] Dynamic subtest rcs0: SUCCESS (0.513s)
[276.422406] Starting dynamic subtest: bcs0
[276.923574] Dynamic subtest bcs0: SUCCESS (0.511s)
[276.936900] Starting dynamic subtest: vcs0
[277.437267] Dynamic subtest vcs0: SUCCESS (0.510s)
[277.450625] Starting dynamic subtest: vcs1
[277.952319] Dynamic subtest vcs1: SUCCESS (0.512s)
[277.968538] Starting dynamic subtest: vecs0
[278.465863] Dynamic subtest vecs0: SUCCESS (0.510s)
[278.479463] Starting dynamic subtest: ccs0
[278.982665] Dynamic subtest ccs0: SUCCESS (0.513s)
[278.985748] Subtest semaphore-wait: SUCCESS (3.089s)
[280.370342] [099/154] (740s left) kms_flip (nonexisting-fb-interruptible)
[280.481320] Starting subtest: nonexisting-fb-interruptible
[280.483639] Starting dynamic subtest: A-eDP1
[281.668904] Dynamic subtest A-eDP1: SUCCESS (1.185s)
[281.681569] Starting dynamic subtest: B-eDP1
[282.801268] Dynamic subtest B-eDP1: SUCCESS (1.133s)
[282.815325] Starting dynamic subtest: C-eDP1
[283.927591] Dynamic subtest C-eDP1: SUCCESS (1.123s)
[283.939085] Starting dynamic subtest: D-eDP1
[285.064365] Dynamic subtest D-eDP1: SUCCESS (1.135s)
[285.069563] Subtest nonexisting-fb-interruptible: SUCCESS (4.588s)
[286.238802] [100/154] (734s left) kms_universal_plane (universal-plane-pageflip-windowed)
[286.340751] Starting subtest: universal-plane-pageflip-windowed
[286.342650] Starting dynamic subtest: pipe-A-eDP-1
[286.890682] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.550s)
[286.903736] Starting dynamic subtest: pipe-B-eDP-1
[288.143925] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.251s)
[288.155626] Starting dynamic subtest: pipe-C-eDP-1
[289.368479] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.221s)
[289.379804] Starting dynamic subtest: pipe-D-eDP-1
[290.587799] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.220s)
[290.590213] Subtest universal-plane-pageflip-windowed: SUCCESS (4.249s)
[291.486056] [101/154] (729s left) kms_pm_rpm (drm-resources-equal)
[293.510155] Starting subtest: drm-resources-equal
[298.525124] Subtest drm-resources-equal: SUCCESS (5.015s)
[298.619056] [102/154] (722s left) kms_pipe_b_c_ivb (pipe-b-dpms-off-modeset-pipe-c)
[298.676620] Subtest pipe-B-dpms-off-modeset-pipe-C: SKIP (0.000s)
[298.743272] [103/154] (722s left) kms_vblank (wait-forked)
[298.843250] Starting subtest: wait-forked
[298.845173] Starting dynamic subtest: pipe-A-eDP-1
[300.661922] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.819s)
[300.680822] Starting dynamic subtest: pipe-D-eDP-1
[303.148751] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.485s)
[303.151497] Subtest wait-forked: SUCCESS (4.308s)
[304.025207] [104/154] (717s left) kms_plane_multiple (tiling-none)
[304.122870] Starting subtest: tiling-none
[304.125322] Starting dynamic subtest: pipe-A-eDP-1
[307.953866] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.829s)
[307.964928] Starting dynamic subtest: pipe-B-eDP-1
[312.526610] Dynamic subtest pipe-B-eDP-1: SUCCESS (4.571s)
[312.537998] Starting dynamic subtest: pipe-C-eDP-1
[317.052209] Dynamic subtest pipe-C-eDP-1: SUCCESS (4.526s)
[317.069154] Starting dynamic subtest: pipe-D-eDP-1
[321.435393] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.382s)
[321.437528] Subtest tiling-none: SUCCESS (17.313s)
[322.243996] [105/154] (698s left) kms_frontbuffer_tracking (fbchdr-2p-primscrn-shrfb-pgflip-blt)
[322.350828] Starting subtest: fbchdr-2p-primscrn-shrfb-pgflip-blt
[322.354985] Subtest fbchdr-2p-primscrn-shrfb-pgflip-blt: SKIP (0.000s)
[322.463906] [106/154] (698s left) gem_exec_nop (basic-sequential)
[322.533242] Starting subtest: basic-sequential
[336.799776] Subtest basic-sequential: SUCCESS (14.274s)
[337.055230] [107/154] (684s left) gem_compute (compute-square)
[337.111238] Starting subtest: compute-square
[337.117822] Subtest compute-square: SUCCESS (0.009s)
[337.246309] [108/154] (683s left) gem_exec_schedule (implicit-read-write)
[337.329813] Starting subtest: implicit-read-write
[337.332137] Starting dynamic subtest: rcs0
[337.513792] Dynamic subtest rcs0: SUCCESS (0.188s)
[337.526041] Starting dynamic subtest: vcs0
[337.621322] Dynamic subtest vcs0: SUCCESS (0.109s)
[337.638137] Starting dynamic subtest: vcs1
[337.731177] Dynamic subtest vcs1: SUCCESS (0.109s)
[337.744036] Starting dynamic subtest: vecs0
[337.844611] Dynamic subtest vecs0: SUCCESS (0.112s)
[337.858321] Starting dynamic subtest: ccs0
[337.979930] Dynamic subtest ccs0: SUCCESS (0.134s)
[337.982902] Subtest implicit-read-write: SUCCESS (0.657s)
[339.460496] [109/154] (681s left) kms_flip (flip-vs-fences-interruptible)
[339.554503] Starting subtest: flip-vs-fences-interruptible
[339.559203] Subtest flip-vs-fences-interruptible: SKIP (0.000s)
[339.653604] [110/154] (681s left) kms_big_fb (y-tiled-8bpp-rotate-180)
[339.755790] Starting subtest: y-tiled-8bpp-rotate-180
[339.760297] Subtest y-tiled-8bpp-rotate-180: SKIP (0.000s)
[339.855478] [111/154] (681s left) kms_psr (fbc-psr-dpms)
[339.944670] Starting subtest: fbc-psr-dpms
[339.946785] Starting dynamic subtest: eDP-1
[339.950656] Dynamic subtest eDP-1: SKIP (0.000s)
[339.954615] Subtest fbc-psr-dpms: SKIP (0.001s)
[340.021722] [112/154] (681s left) syncobj_timeline (multi-wait-signaled)
[340.070647] Starting subtest: multi-wait-signaled
[340.073053] Subtest multi-wait-signaled: SUCCESS (0.001s)
[340.155847] [113/154] (681s left) perf_pmu (busy-accuracy-50)
[340.195567] Starting subtest: busy-accuracy-50
[340.197902] Starting dynamic subtest: rcs0
[341.733725] Dynamic subtest rcs0: SUCCESS (1.534s)
[341.747114] Starting dynamic subtest: bcs0
[343.277464] Dynamic subtest bcs0: SUCCESS (1.541s)
[343.289624] Starting dynamic subtest: vcs0
[344.814793] Dynamic subtest vcs0: SUCCESS (1.536s)
[344.825140] Starting dynamic subtest: vcs1
[346.358062] Dynamic subtest vcs1: SUCCESS (1.541s)
[346.370694] Starting dynamic subtest: vecs0
[347.895278] Dynamic subtest vecs0: SUCCESS (1.536s)
[347.906645] Starting dynamic subtest: ccs0
[349.444053] Dynamic subtest ccs0: SUCCESS (1.546s)
[349.446868] Subtest busy-accuracy-50: SUCCESS (9.247s)
[349.563504] [114/154] (671s left) gem_mmap_gtt (basic-write-read-distinct)
[349.620245] Subtest basic-write-read-distinct: SKIP (0.000s)
[349.681973] [115/154] (671s left) kms_ccs (missing-ccs-buffer-y-tiled-ccs)
[349.778110] Starting subtest: missing-ccs-buffer-y-tiled-ccs
[349.780434] Starting dynamic subtest: pipe-A-eDP-1
[349.803239] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[349.820073] Starting dynamic subtest: pipe-B-eDP-1
[349.842075] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[349.851813] Starting dynamic subtest: pipe-C-eDP-1
[349.873388] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[349.882644] Starting dynamic subtest: pipe-D-eDP-1
[349.904412] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[349.908717] Subtest missing-ccs-buffer-y-tiled-ccs: SKIP (0.004s)
[352.112248] [116/154] (669s left) gem_exec_whisper (basic-normal)
[352.174471] Starting subtest: basic-normal
[356.949812] Subtest basic-normal: SUCCESS (4.775s)
[357.133846] [117/154] (664s left) kms_flip (2x-modeset-vs-vblank-race)
[357.232063] Starting subtest: 2x-modeset-vs-vblank-race
[357.242407] Subtest 2x-modeset-vs-vblank-race: SKIP (0.012s)
[357.356361] [118/154] (664s left) gem_create (create-invalid-size)
[357.413491] Starting subtest: create-invalid-size
[357.415362] Subtest create-invalid-size: SUCCESS (0.000s)
[357.598628] [119/154] (664s left) kms_frontbuffer_tracking (hdr-2p-scndscrn-pri-indfb-draw-pwrite)
[357.696374] Starting subtest: hdr-2p-scndscrn-pri-indfb-draw-pwrite
[357.700628] Subtest hdr-2p-scndscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[357.805590] [120/154] (663s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-pwrite)
[357.908517] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-pwrite
[357.913148] Subtest psr-2p-scndscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[358.017016] [121/154] (663s left) kms_frontbuffer_tracking (psrhdr-1p-rte)
[358.117284] Starting subtest: psrhdr-1p-rte
[358.121576] Subtest psrhdr-1p-rte: SKIP (0.000s)
[358.222846] [122/154] (663s left) kms_chamelium_frames (vga-frame-dump)
[358.600554] Subtest vga-frame-dump: SKIP (0.000s)
[359.411234] [123/154] (662s left) kms_big_fb (linear-8bpp-rotate-90)
[359.527551] Starting subtest: linear-8bpp-rotate-90
[359.550166] Subtest linear-8bpp-rotate-90: SKIP (0.022s)
[359.681231] [124/154] (662s left) kms_psr (psr2-cursor-plane-move)
[359.768842] Starting subtest: psr2-cursor-plane-move
[359.771166] Starting dynamic subtest: eDP-1
[361.503856] Dynamic subtest eDP-1: SUCCESS (1.736s)
[361.506251] Subtest psr2-cursor-plane-move: SUCCESS (1.737s)
[362.407205] [125/154] (659s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-render)
[362.525461] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-render
[362.529715] Subtest fbc-2p-primscrn-spr-indfb-draw-render: SKIP (0.000s)
[362.622579] [126/154] (659s left) kms_prop_blob (basic)
[362.685865] Starting subtest: basic
[362.688074] Subtest basic: SUCCESS (0.000s)
[362.807838] [127/154] (659s left) kms_frontbuffer_tracking (hdr-2p-primscrn-cur-indfb-draw-render)
[362.897053] Starting subtest: hdr-2p-primscrn-cur-indfb-draw-render
[362.901157] Subtest hdr-2p-primscrn-cur-indfb-draw-render: SKIP (0.000s)
[362.998283] [128/154] (659s left) kms_frontbuffer_tracking (fbc-2p-shrfb-fliptrack-mmap-gtt)
[363.108046] Starting subtest: fbc-2p-shrfb-fliptrack-mmap-gtt
[363.112197] Subtest fbc-2p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s)
[363.212531] [129/154] (658s left) gem_softpin (evict-active)
[363.272335] Starting subtest: evict-active
[363.278773] Subtest evict-active: SUCCESS (0.006s)
[363.401938] [130/154] (658s left) kms_lease (lease-invalid-connector)
[363.494072] Starting subtest: lease-invalid-connector
[363.495981] Starting dynamic subtest: pipe-A-eDP-1
[363.498077] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s)
[363.509525] Starting dynamic subtest: pipe-B-eDP-1
[363.511133] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[363.521044] Starting dynamic subtest: pipe-C-eDP-1
[363.522794] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[363.532515] Starting dynamic subtest: pipe-D-eDP-1
[363.534382] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[363.536226] Subtest lease-invalid-connector: SUCCESS (0.004s)
[363.573996] [131/154] (658s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-shrfb-pgflip-blt)
[363.675074] Starting subtest: fbcpsr-2p-primscrn-shrfb-pgflip-blt
[363.678383] Subtest fbcpsr-2p-primscrn-shrfb-pgflip-blt: SKIP (0.000s)
[363.770968] [132/154] (658s left) kms_flip (absolute-wf_vblank)
[363.865537] Starting subtest: absolute-wf_vblank
[363.867196] Starting dynamic subtest: A-eDP1
[372.653427] Dynamic subtest A-eDP1: SUCCESS (8.789s)
[372.666469] Starting dynamic subtest: B-eDP1
[381.386703] Dynamic subtest B-eDP1: SUCCESS (8.732s)
[381.399685] Starting dynamic subtest: C-eDP1
[390.103234] Dynamic subtest C-eDP1: SUCCESS (8.713s)
[390.116673] Starting dynamic subtest: D-eDP1
[398.833713] Dynamic subtest D-eDP1: SUCCESS (8.729s)
[398.839253] Subtest absolute-wf_vblank: SUCCESS (34.973s)
[400.055889] [133/154] (622s left) gem_mmap_wc (bad-object)
[400.107797] Subtest bad-object: SKIP (0.000s)
[400.166812] [134/154] (622s left) kms_selftest (drm_dp_mst_helper)
[400.214863] Starting subtest: drm_dp_mst_helper
[400.243190] Starting dynamic subtest: drm_test_dp_mst_calc_pbn_mode
[400.333062] Dynamic subtest drm_test_dp_mst_calc_pbn_mode: SUCCESS (0.090s)
[400.343534] Starting dynamic subtest: drm_test_dp_mst_calc_pbn_div
[400.436490] Dynamic subtest drm_test_dp_mst_calc_pbn_div: SUCCESS (0.101s)
[400.446328] Starting dynamic subtest: drm_test_dp_mst_sideband_msg_req_decode
[400.532255] Dynamic subtest drm_test_dp_mst_sideband_msg_req_decode: SUCCESS (0.094s)
[400.534140] Subtest drm_dp_mst_helper: SUCCESS (0.316s)
[400.692910] [135/154] (621s left) kms_chamelium_hpd (hdmi-hpd-fast)
[401.090963] Subtest hdmi-hpd-fast: SKIP (0.000s)
[401.877630] [136/154] (620s left) kms_cursor_crc (cursor-rapid-movement-128x128)
[402.093219] Starting subtest: cursor-rapid-movement-128x128
[402.095487] Starting dynamic subtest: pipe-A-eDP-1
[402.650458] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.554s)
[402.680861] Starting dynamic subtest: pipe-D-eDP-1
[403.919274] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.245s)
[403.921488] Subtest cursor-rapid-movement-128x128: SUCCESS (1.827s)
[404.761863] [137/154] (617s left) syncobj_timeline (etime-single-wait-submitted)
[404.817298] Starting subtest: etime-single-wait-submitted
[404.924073] Subtest etime-single-wait-submitted: SUCCESS (0.105s)
[405.000782] [138/154] (617s left) kms_frontbuffer_tracking (psrhdr-2p-primscrn-spr-indfb-fullscreen)
[405.107354] Starting subtest: psrhdr-2p-primscrn-spr-indfb-fullscreen
[405.111850] Subtest psrhdr-2p-primscrn-spr-indfb-fullscreen: SKIP (0.000s)
[405.207425] [139/154] (617s left) kms_frontbuffer_tracking (fbc-tiling-linear)
[405.310415] Starting subtest: fbc-tiling-linear
[409.117605] Subtest fbc-tiling-linear: SUCCESS (3.814s)
[410.270843] [140/154] (612s left) gem_lmem_swapping (verify-random-ccs)
[410.316142] Subtest verify-random-ccs: SKIP (0.000s)
[410.359303] [141/154] (612s left) perf (invalid-open-flags)
[410.460952] Starting subtest: invalid-open-flags
[410.463204] Subtest invalid-open-flags: SUCCESS (0.000s)
[410.507793] [142/154] (612s left) gem_mmap_gtt (flink-race)
[410.566837] Subtest flink-race: SKIP (0.000s)
[410.629120] [143/154] (612s left) kms_cursor_legacy (cursorb-vs-flipb-atomic-transitions-varying-size)
[410.744414] Starting subtest: cursorB-vs-flipB-atomic-transitions-varying-size
[410.748970] Subtest cursorB-vs-flipB-atomic-transitions-varying-size: SKIP (0.001s)
[410.893333] [144/154] (611s left) gem_ctx_persistence (saturated-hostile-nopreempt)
[410.959215] Starting subtest: saturated-hostile-nopreempt
[410.961597] Starting dynamic subtest: rcs0
[411.020648] Dynamic subtest rcs0: SKIP (0.059s)
[411.033689] Starting dynamic subtest: bcs0
[411.037916] Dynamic subtest bcs0: SKIP (0.015s)
[411.047855] Starting dynamic subtest: vcs0
[411.054515] Dynamic subtest vcs0: SKIP (0.016s)
[411.065818] Starting dynamic subtest: vcs1
[411.072623] Dynamic subtest vcs1: SKIP (0.017s)
[411.082647] Starting dynamic subtest: vecs0
[411.089279] Dynamic subtest vecs0: SKIP (0.015s)
[411.099082] Starting dynamic subtest: ccs0
[411.103531] Dynamic subtest ccs0: SKIP (0.012s)
[411.108052] Subtest saturated-hostile-nopreempt: SKIP (0.141s)
[411.199539] [145/154] (611s left) gem_ctx_isolation (nonpriv-switch)
[411.251454] Starting subtest: nonpriv-switch
[411.253263] Starting dynamic subtest: rcs0
[411.530054] Dynamic subtest rcs0: SUCCESS (0.278s)
[411.542476] Starting dynamic subtest: bcs0
[411.822289] Dynamic subtest bcs0: SUCCESS (0.291s)
[411.836204] Starting dynamic subtest: vcs0
[412.130518] Dynamic subtest vcs0: SUCCESS (0.307s)
[412.143702] Starting dynamic subtest: vcs1
[413.637536] Dynamic subtest vcs1: SUCCESS (1.506s)
[413.648049] Starting dynamic subtest: vecs0
[415.646974] Dynamic subtest vecs0: SUCCESS (2.008s)
[415.659400] Starting dynamic subtest: ccs0
[417.644092] Dynamic subtest ccs0: SUCCESS (1.996s)
[417.646452] Subtest nonpriv-switch: SUCCESS (6.393s)
[417.885543] [146/154] (604s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-mmap-wc)
[417.986333] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-mmap-wc
[417.990611] Subtest fbc-2p-scndscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[418.097049] [147/154] (604s left) i915_module_load (resize-bar)
[418.132388] Starting subtest: resize-bar
[418.139311] Subtest resize-bar: SKIP (0.006s)
[418.183592] [148/154] (604s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-16bpp-4tile-downscaling)
[418.283963] Starting subtest: flip-64bpp-4tile-to-16bpp-4tile-downscaling
[418.287198] Starting dynamic subtest: pipe-A-default-mode
[419.422900] Dynamic subtest pipe-A-default-mode: SKIP (1.138s)
[419.427104] Subtest flip-64bpp-4tile-to-16bpp-4tile-downscaling: SKIP (1.139s)
[419.558780] [149/154] (603s left) gem_ctx_bad_destroy (invalid-ctx)
[419.613766] Starting subtest: invalid-ctx
[419.616076] Subtest invalid-ctx: SUCCESS (0.000s)
[419.707967] [150/154] (603s left) drm_read (short-buffer-wakeup)
[419.856040] Starting subtest: short-buffer-wakeup
[452.071564] Subtest short-buffer-wakeup: SUCCESS (32.216s)
[452.223314] [151/154] (570s left) kms_content_protection (content-type-change)
[452.361111] Starting subtest: content-type-change
[452.365615] Subtest content-type-change: SKIP (0.000s)
[452.494985] [152/154] (570s left) kms_flip_scaled_crc (flip-32bpp-linear-to-64bpp-linear-downscaling)
[452.602895] Starting subtest: flip-32bpp-linear-to-64bpp-linear-downscaling
[452.605281] Starting dynamic subtest: pipe-A-default-mode
[453.751377] Dynamic subtest pipe-A-default-mode: SKIP (1.147s)
[453.755688] Subtest flip-32bpp-linear-to-64bpp-linear-downscaling: SKIP (1.149s)
[453.900709] [153/154] (569s left) kms_frontbuffer_tracking (psr-2p-primscrn-shrfb-plflip-blt)
[453.998756] Starting subtest: psr-2p-primscrn-shrfb-plflip-blt
[454.003119] Subtest psr-2p-primscrn-shrfb-plflip-blt: SKIP (0.000s)
[454.086382] [154/154] (569s left) kms_frontbuffer_tracking (hdr-2p-primscrn-spr-indfb-move)
[454.179578] Starting subtest: hdr-2p-primscrn-spr-indfb-move
[454.183563] Subtest hdr-2p-primscrn-spr-indfb-move: SKIP (0.000s)
[454.272774] Closing watchdogs
results: parsing output: 0/ for test: kms_color
results: parsing output: 1/ for test: kms_frontbuffer_tracking
results: parsing output: 2/ for test: gen9_exec_parse
results: parsing output: 3/ for test: fbdev
results: parsing output: 4/ for test: vgem_basic
results: parsing output: 5/ for test: kms_getfb
results: parsing output: 6/ for test: kms_psr2_sf
results: parsing output: 7/ for test: kms_cursor_crc
results: parsing output: 8/ for test: kms_psr2_sf
results: parsing output: 9/ for test: gem_ppgtt
results: parsing output: 10/ for test: kms_frontbuffer_tracking
results: parsing output: 11/ for test: perf
results: parsing output: 12/ for test: gem_userptr_blits
results: parsing output: 13/ for test: kms_flip
results: parsing output: 14/ for test: kms_frontbuffer_tracking
results: parsing output: 15/ for test: gem_close_race
results: parsing output: 16/ for test: kms_cursor_legacy
results: parsing output: 17/ for test: kms_frontbuffer_tracking
results: parsing output: 18/ for test: gem_eio
results: parsing output: 19/ for test: gem_exec_flush
results: parsing output: 20/ for test: kms_plane
results: parsing output: 21/ for test: kms_frontbuffer_tracking
results: parsing output: 22/ for test: syncobj_wait
results: parsing output: 23/ for test: kms_frontbuffer_tracking
results: parsing output: 24/ for test: kms_ccs
results: parsing output: 25/ for test: i915_pm_rps
results: parsing output: 26/ for test: syncobj_wait
results: parsing output: 27/ for test: syncobj_basic
results: parsing output: 28/ for test: kms_cursor_legacy
results: parsing output: 29/ for test: syncobj_eventfd
results: parsing output: 30/ for test: prime_vgem
results: parsing output: 31/ for test: api_intel_bb
results: parsing output: 32/ for test: kms_frontbuffer_tracking
results: parsing output: 33/ for test: i915_pm_rpm
results: parsing output: 34/ for test: gem_exec_schedule
results: parsing output: 35/ for test: gem_lmem_swapping
results: parsing output: 36/ for test: gem_spin_batch
results: parsing output: 37/ for test: kms_frontbuffer_tracking
results: parsing output: 38/ for test: kms_frontbuffer_tracking
results: parsing output: 39/ for test: kms_big_fb
results: parsing output: 40/ for test: kms_frontbuffer_tracking
results: parsing output: 41/ for test: kms_frontbuffer_tracking
results: parsing output: 42/ for test: kms_big_fb
results: parsing output: 43/ for test: gem_exec_gttfill
results: parsing output: 44/ for test: kms_pm_backlight
results: parsing output: 45/ for test: kms_pipe_stress
results: parsing output: 46/ for test: gem_exec_balancer
results: parsing output: 47/ for test: gem_eio
results: parsing output: 48/ for test: kms_frontbuffer_tracking
results: parsing output: 49/ for test: kms_dirtyfb
results: parsing output: 50/ for test: kms_chamelium_color
results: parsing output: 51/ for test: kms_big_fb
results: parsing output: 52/ for test: kms_frontbuffer_tracking
results: parsing output: 53/ for test: gem_render_copy
results: parsing output: 54/ for test: kms_ccs
results: parsing output: 55/ for test: kms_frontbuffer_tracking
results: parsing output: 56/ for test: kms_frontbuffer_tracking
results: parsing output: 57/ for test: kms_psr
results: parsing output: 58/ for test: kms_atomic
results: parsing output: 59/ for test: gem_exec_fence
results: parsing output: 60/ for test: kms_frontbuffer_tracking
results: parsing output: 61/ for test: syncobj_timeline
results: parsing output: 62/ for test: kms_frontbuffer_tracking
results: parsing output: 63/ for test: gem_mmap_gtt
results: parsing output: 64/ for test: syncobj_timeline
results: parsing output: 65/ for test: kms_frontbuffer_tracking
results: parsing output: 66/ for test: kms_frontbuffer_tracking
results: parsing output: 67/ for test: gem_exec_params
results: parsing output: 68/ for test: gem_exec_params
results: parsing output: 69/ for test: kms_async_flips
results: parsing output: 70/ for test: kms_frontbuffer_tracking
results: parsing output: 71/ for test: kms_joiner
results: parsing output: 72/ for test: gem_exec_reloc
results: parsing output: 73/ for test: kms_frontbuffer_tracking
results: parsing output: 74/ for test: kms_frontbuffer_tracking
results: parsing output: 75/ for test: kms_draw_crc
results: parsing output: 76/ for test: kms_plane_scaling
results: parsing output: 77/ for test: kms_frontbuffer_tracking
results: parsing output: 78/ for test: kms_big_fb
results: parsing output: 79/ for test: gem_exec_schedule
results: parsing output: 80/ for test: api_intel_allocator
results: parsing output: 81/ for test: kms_frontbuffer_tracking
results: parsing output: 82/ for test: kms_psr
results: parsing output: 83/ for test: kms_cursor_crc
results: parsing output: 84/ for test: kms_frontbuffer_tracking
results: parsing output: 85/ for test: gem_render_copy
results: parsing output: 86/ for test: kms_frontbuffer_tracking
results: parsing output: 87/ for test: kms_ccs
results: parsing output: 88/ for test: kms_frontbuffer_tracking
results: parsing output: 89/ for test: kms_frontbuffer_tracking
results: parsing output: 90/ for test: kms_ccs
results: parsing output: 91/ for test: kms_frontbuffer_tracking
results: parsing output: 92/ for test: kms_cursor_legacy
results: parsing output: 93/ for test: gem_exec_reloc
results: parsing output: 94/ for test: gem_exec_balancer
results: parsing output: 95/ for test: gen9_exec_parse
results: parsing output: 96/ for test: kms_psr
results: parsing output: 97/ for test: perf_pmu
results: parsing output: 98/ for test: kms_flip
results: parsing output: 99/ for test: kms_universal_plane
results: parsing output: 100/ for test: kms_pm_rpm
results: parsing output: 101/ for test: kms_pipe_b_c_ivb
results: parsing output: 102/ for test: kms_vblank
results: parsing output: 103/ for test: kms_plane_multiple
results: parsing output: 104/ for test: kms_frontbuffer_tracking
results: parsing output: 105/ for test: gem_exec_nop
results: parsing output: 106/ for test: gem_compute
results: parsing output: 107/ for test: gem_exec_schedule
results: parsing output: 108/ for test: kms_flip
results: parsing output: 109/ for test: kms_big_fb
results: parsing output: 110/ for test: kms_psr
results: parsing output: 111/ for test: syncobj_timeline
results: parsing output: 112/ for test: perf_pmu
results: parsing output: 113/ for test: gem_mmap_gtt
results: parsing output: 114/ for test: kms_ccs
results: parsing output: 115/ for test: gem_exec_whisper
results: parsing output: 116/ for test: kms_flip
results: parsing output: 117/ for test: gem_create
results: parsing output: 118/ for test: kms_frontbuffer_tracking
results: parsing output: 119/ for test: kms_frontbuffer_tracking
results: parsing output: 120/ for test: kms_frontbuffer_tracking
results: parsing output: 121/ for test: kms_chamelium_frames
results: parsing output: 122/ for test: kms_big_fb
results: parsing output: 123/ for test: kms_psr
results: parsing output: 124/ for test: kms_frontbuffer_tracking
results: parsing output: 125/ for test: kms_prop_blob
results: parsing output: 126/ for test: kms_frontbuffer_tracking
results: parsing output: 127/ for test: kms_frontbuffer_tracking
results: parsing output: 128/ for test: gem_softpin
results: parsing output: 129/ for test: kms_lease
results: parsing output: 130/ for test: kms_frontbuffer_tracking
results: parsing output: 131/ for test: kms_flip
results: parsing output: 132/ for test: gem_mmap_wc
results: parsing output: 133/ for test: kms_selftest
results: parsing output: 134/ for test: kms_chamelium_hpd
results: parsing output: 135/ for test: kms_cursor_crc
results: parsing output: 136/ for test: syncobj_timeline
results: parsing output: 137/ for test: kms_frontbuffer_tracking
results: parsing output: 138/ for test: kms_frontbuffer_tracking
results: parsing output: 139/ for test: gem_lmem_swapping
results: parsing output: 140/ for test: perf
results: parsing output: 141/ for test: gem_mmap_gtt
results: parsing output: 142/ for test: kms_cursor_legacy
results: parsing output: 143/ for test: gem_ctx_persistence
results: parsing output: 144/ for test: gem_ctx_isolation
results: parsing output: 145/ for test: kms_frontbuffer_tracking
results: parsing output: 146/ for test: i915_module_load
results: parsing output: 147/ for test: kms_flip_scaled_crc
results: parsing output: 148/ for test: gem_ctx_bad_destroy
results: parsing output: 149/ for test: drm_read
results: parsing output: 150/ for test: kms_content_protection
results: parsing output: 151/ for test: kms_flip_scaled_crc
results: parsing output: 152/ for test: kms_frontbuffer_tracking
results: parsing output: 153/ for test: kms_frontbuffer_tracking
Done.