[58.586547] Initializing watchdogs
[58.586590]   /dev/watchdog0
[58.602249] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7dd5 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Graphics]
[58.606407] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[58.608366] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[58.612263] [001/133] (960s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-mmap-wc)
[58.719743] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-mmap-wc
[58.724255] Subtest fbc-2p-scndscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[58.827071] [002/133] (960s left) vgem_basic (second-client)
[58.892762] Starting subtest: second-client
[58.914526] Subtest second-client: SUCCESS (0.022s)
[58.969953] [FACT vgem_basic (second-client)] new: kernel.kmod_is_loaded.vgem: true
[58.972829] [003/133] (960s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-mmap-gtt)
[59.046725] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-mmap-gtt
[59.051015] Subtest psr-2p-scndscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[59.138151] [004/133] (960s left) gem_madvise (dontneed-before-exec)
[59.175454] Starting subtest: dontneed-before-exec
[59.195286] Subtest dontneed-before-exec: SKIP (0.018s)
[59.258629] [005/133] (960s left) kms_async_flips (async-flip-suspend-resume)
[59.345579] Starting subtest: async-flip-suspend-resume
[60.444094] Starting dynamic subtest: pipe-A-eDP-1
[78.167926] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.729s)
[78.552124] Starting dynamic subtest: pipe-B-eDP-1
[96.167371] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.920s)
[96.591821] Starting dynamic subtest: pipe-C-eDP-1
[114.176119] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.858s)
[114.547442] Starting dynamic subtest: pipe-D-eDP-1
[132.156899] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.867s)
[132.173501] Subtest async-flip-suspend-resume: SUCCESS (13.615s)
[133.383267] [006/133] (885s left) perf_pmu (most-busy-idle-check-all)
[133.433648] Starting subtest: most-busy-idle-check-all
[133.436169] Starting dynamic subtest: rcs0
[134.928212] Dynamic subtest rcs0: SUCCESS (1.475s)
[134.939913] Starting dynamic subtest: bcs0
[136.913835] Dynamic subtest bcs0: SUCCESS (1.964s)
[136.926170] Starting dynamic subtest: vcs0
[138.896257] Dynamic subtest vcs0: SUCCESS (1.966s)
[138.908001] Starting dynamic subtest: vcs1
[140.880677] Dynamic subtest vcs1: SUCCESS (1.971s)
[140.892453] Starting dynamic subtest: vecs0
[142.928241] Dynamic subtest vecs0: SUCCESS (2.037s)
[142.940107] Starting dynamic subtest: ccs0
[144.914720] Dynamic subtest ccs0: SUCCESS (1.977s)
[144.918005] Subtest most-busy-idle-check-all: SUCCESS (11.397s)
[145.033134] [007/133] (874s left) syncobj_timeline (multi-wait-all-available-submitted-signaled)
[145.093197] Starting subtest: multi-wait-all-available-submitted-signaled
[145.095653] Subtest multi-wait-all-available-submitted-signaled: SUCCESS (0.001s)
[145.180057] [008/133] (874s left) kms_chamelium_hpd (hdmi-hpd)
[145.557310] Subtest hdmi-hpd: SKIP (0.000s)
[146.383065] [009/133] (873s left) perf_pmu (busy-double-start)
[146.426811] Starting subtest: busy-double-start
[146.429129] Starting dynamic subtest: rcs0
[150.067514] Dynamic subtest rcs0: FAIL (3.582s)
[150.076031] Starting dynamic subtest: bcs0
[153.590047] Dynamic subtest bcs0: SUCCESS (3.567s)
[153.600983] Starting dynamic subtest: vcs0
[157.390880] Dynamic subtest vcs0: SUCCESS (3.795s)
[157.402310] Starting dynamic subtest: vcs1
[161.446832] Dynamic subtest vcs1: SUCCESS (4.051s)
[161.457384] Starting dynamic subtest: vecs0
[165.390966] Dynamic subtest vecs0: SUCCESS (3.940s)
[165.401755] Starting dynamic subtest: ccs0
[168.963371] Dynamic subtest ccs0: SUCCESS (3.573s)
[168.965954] Subtest busy-double-start: FAIL (22.514s)
[169.073833] [010/133] (850s left) gem_ctx_persistence (many-contexts)
[169.151298] Starting subtest: many-contexts
[206.854239] Subtest many-contexts: SUCCESS (37.702s)
[206.943910] [011/133] (812s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-blt)
[207.031805] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-blt
[213.919259] Subtest psr-1p-offscreen-pri-shrfb-draw-blt: SUCCESS (6.887s)
[214.043002] [012/133] (805s left) gem_exec_schedule (out-order)
[214.126892] Starting subtest: out-order
[214.128983] Starting dynamic subtest: rcs0
[214.251449] Dynamic subtest rcs0: SUCCESS (0.132s)
[214.263647] Starting dynamic subtest: vcs0
[214.331066] Dynamic subtest vcs0: SUCCESS (0.078s)
[214.341957] Starting dynamic subtest: vcs1
[214.405530] Dynamic subtest vcs1: SUCCESS (0.074s)
[214.417124] Starting dynamic subtest: vecs0
[214.484270] Dynamic subtest vecs0: SUCCESS (0.078s)
[214.496052] Starting dynamic subtest: ccs0
[214.568368] Dynamic subtest ccs0: SUCCESS (0.083s)
[214.570851] Subtest out-order: SUCCESS (0.449s)
[215.963829] [013/133] (803s left) gem_mmap_gtt (medium-copy)
[216.017182] Subtest medium-copy: SKIP (0.000s)
[216.072395] [014/133] (803s left) gem_mmap_offset (close-race)
[216.114712] Starting subtest: close-race
[236.218750] Subtest close-race: SUCCESS (20.101s)
[236.343191] [015/133] (783s left) kms_ccs (crc-primary-suspend-y-tiled-gen12-rc-ccs-cc)
[236.422101] Starting subtest: crc-primary-suspend-y-tiled-gen12-rc-ccs-cc
[236.424440] Starting dynamic subtest: pipe-A-eDP-1
[236.433870] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[236.443653] Starting dynamic subtest: pipe-B-eDP-1
[236.452612] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[236.460390] Starting dynamic subtest: pipe-C-eDP-1
[236.468661] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[236.476415] Starting dynamic subtest: pipe-D-eDP-1
[236.484787] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[236.488831] Subtest crc-primary-suspend-y-tiled-gen12-rc-ccs-cc: SKIP (0.003s)
[238.690029] [016/133] (781s left) kms_psr (fbc-psr2-dpms)
[238.763756] Starting subtest: fbc-psr2-dpms
[238.766051] Starting dynamic subtest: eDP-1
[238.770300] Dynamic subtest eDP-1: SKIP (0.000s)
[238.774495] Subtest fbc-psr2-dpms: SKIP (0.000s)
[238.837348] [017/133] (780s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-render)
[238.916884] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-render
[243.303095] Subtest fbc-1p-primscrn-pri-indfb-draw-render: SUCCESS (4.392s)
[244.520552] [018/133] (775s left) gem_vm_create (isolation)
[244.590964] Starting subtest: isolation
[244.599804] Subtest isolation: SUCCESS (0.009s)
[244.710618] [019/133] (775s left) kms_hdr (static-toggle-dpms)
[244.787132] Starting subtest: static-toggle-dpms
[244.793805] Subtest static-toggle-dpms: SKIP (0.000s)
[244.857777] [020/133] (775s left) gem_exec_balancer (sequential)
[244.915602] Starting subtest: sequential
[247.959808] Subtest sequential: SUCCESS (3.046s)
[248.268917] [021/133] (771s left) kms_chamelium_audio (hdmi-audio-edid)
[248.642399] Subtest hdmi-audio-edid: SKIP (0.000s)
[249.484631] [022/133] (770s left) kms_pm_rpm (legacy-planes)
[251.016076] Starting subtest: legacy-planes
[251.018613] Starting dynamic subtest: plane-64
[259.285507] Dynamic subtest plane-64: SUCCESS (8.272s)
[259.295725] Starting dynamic subtest: plane-94
[267.552661] Dynamic subtest plane-94: SUCCESS (8.264s)
[267.564221] Starting dynamic subtest: plane-124
[275.818029] Dynamic subtest plane-124: SUCCESS (8.263s)
[275.830898] Starting dynamic subtest: plane-134
[284.135197] Dynamic subtest plane-134: SUCCESS (8.315s)
[284.138233] Subtest legacy-planes: SUCCESS (33.120s)
[284.494011] [023/133] (735s left) kms_prop_blob (blob-prop-lifetime)
[284.566903] Starting subtest: blob-prop-lifetime
[284.569221] Subtest blob-prop-lifetime: SUCCESS (0.001s)
[284.672213] [024/133] (735s left) gem_ctx_param (invalid-set-ringsize)
[284.725610] Starting subtest: invalid-set-ringsize
[284.728353] Subtest invalid-set-ringsize: SUCCESS (0.000s)
[284.805662] [025/133] (735s left) kms_big_fb (y-tiled-32bpp-rotate-0)
[284.888830] Starting subtest: y-tiled-32bpp-rotate-0
[284.893086] Subtest y-tiled-32bpp-rotate-0: SKIP (0.000s)
[284.998682] [026/133] (735s left) gem_reg_read (bad-register)
[285.052423] Starting subtest: bad-register
[285.054725] Subtest bad-register: SUCCESS (0.000s)
[285.161003] [027/133] (735s left) kms_addfb_basic (bad-pitch-63)
[285.221358] Starting subtest: bad-pitch-63
[285.223245] Subtest bad-pitch-63: SUCCESS (0.000s)
[285.336332] [028/133] (734s left) syncobj_timeline (etime-multi-wait-all-for-submit-available-unsubmitted-signa
[285.384842] Starting subtest: etime-multi-wait-all-for-submit-available-unsubmitted-signaled
[285.492031] Subtest etime-multi-wait-all-for-submit-available-unsubmitted-signaled: SUCCESS (0.106s)
[285.567126] [029/133] (734s left) i915_pm_freq_api (freq-reset-multiple)
[285.625233] Starting subtest: freq-reset-multiple
[285.627504] Starting dynamic subtest: gt0
[295.249972] Dynamic subtest gt0: SUCCESS (9.621s)
[295.259907] Starting dynamic subtest: gt1
[303.592711] Dynamic subtest gt1: SUCCESS (8.341s)
[303.595399] Subtest freq-reset-multiple: SUCCESS (17.963s)
[303.685550] [030/133] (716s left) kms_addfb_basic (unused-handle)
[303.734824] Starting subtest: unused-handle
[303.738230] Subtest unused-handle: SUCCESS (0.000s)
[303.850789] [031/133] (716s left) i915_pm_rpm (gem-mmap-type)
[306.050108] Starting subtest: gem-mmap-type
[306.053001] Starting dynamic subtest: wb-smem0
[309.161002] Dynamic subtest wb-smem0: SUCCESS (3.109s)
[309.171215] Starting dynamic subtest: wc-smem0
[311.983211] Dynamic subtest wc-smem0: SUCCESS (2.821s)
[311.994907] Starting dynamic subtest: uc-smem0
[314.831712] Dynamic subtest uc-smem0: SUCCESS (2.848s)
[314.834092] Subtest gem-mmap-type: SUCCESS (8.781s)
[314.918705] [032/133] (705s left) gem_mmap_gtt (fault-concurrent-x)
[314.975222] Subtest fault-concurrent-X: SKIP (0.000s)
[315.032400] [033/133] (705s left) gem_exec_reloc (basic-cpu-gtt-noreloc)
[315.088428] Subtest basic-cpu-gtt-noreloc: SKIP (0.000s)
[315.154664] [034/133] (705s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-blt)
[315.227350] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-blt
[318.878522] Subtest fbc-1p-primscrn-cur-indfb-draw-blt: SUCCESS (3.654s)
[320.080460] [035/133] (700s left) kms_dp_link_training (non-uhbr-mst)
[320.151247] Starting subtest: non-uhbr-mst
[320.159820] Subtest non-uhbr-mst: SKIP (0.000s)
[320.223224] [036/133] (700s left) sw_sync (sync_multi_consumer_producer)
[320.262785] Starting subtest: sync_multi_consumer_producer
[320.543726] Subtest sync_multi_consumer_producer: SUCCESS (0.280s)
[320.602408] [037/133] (699s left) kms_psr2_sf (psr2-cursor-plane-move-continuous-exceed-sf)
[320.679264] Starting subtest: psr2-cursor-plane-move-continuous-exceed-sf
[320.681671] Starting dynamic subtest: pipe-A-eDP-1
[331.356967] Dynamic subtest pipe-A-eDP-1: SUCCESS (10.678s)
[331.370916] Starting dynamic subtest: pipe-B-eDP-1
[342.780659] Dynamic subtest pipe-B-eDP-1: SUCCESS (11.420s)
[342.782543] Subtest psr2-cursor-plane-move-continuous-exceed-sf: SUCCESS (22.100s)
[343.635611] [038/133] (677s left) kms_lease (implicit-plane-lease)
[343.720394] Starting subtest: implicit-plane-lease
[343.722722] Subtest implicit-plane-lease: SUCCESS (0.002s)
[343.826336] [039/133] (676s left) kms_frontbuffer_tracking (fbc-rgb565-draw-mmap-wc)
[343.902069] Starting subtest: fbc-rgb565-draw-mmap-wc
[347.962803] Subtest fbc-rgb565-draw-mmap-wc: SUCCESS (4.063s)
[349.130378] [040/133] (671s left) kms_psr (fbc-psr-dpms)
[349.201362] Starting subtest: fbc-psr-dpms
[349.203653] Starting dynamic subtest: eDP-1
[349.207869] Dynamic subtest eDP-1: SKIP (0.000s)
[349.212023] Subtest fbc-psr-dpms: SKIP (0.001s)
[349.274221] [041/133] (671s left) gen9_exec_parse (bb-oversize)
[349.333027] Subtest bb-oversize: SKIP (0.000s)
[349.401564] [042/133] (671s left) kms_scaling_modes (scaling-mode-none)
[349.470509] Starting subtest: scaling-mode-none
[349.472546] Starting dynamic subtest: pipe-A-eDP-1
[349.567285] Dynamic subtest pipe-A-eDP-1: SKIP (0.096s)
[349.577373] Starting dynamic subtest: pipe-B-eDP-1
[349.601799] Dynamic subtest pipe-B-eDP-1: SKIP (0.032s)
[349.611002] Starting dynamic subtest: pipe-C-eDP-1
[349.636633] Dynamic subtest pipe-C-eDP-1: SKIP (0.034s)
[349.645836] Starting dynamic subtest: pipe-D-eDP-1
[349.671441] Dynamic subtest pipe-D-eDP-1: SKIP (0.034s)
[349.675460] Subtest scaling-mode-none: SKIP (0.201s)
[349.780182] [043/133] (671s left) i915_selftest (live)
[351.506522] Starting subtest: live
[351.509003] Starting dynamic subtest: sanitycheck
[355.817765] Dynamic subtest sanitycheck: SUCCESS (4.313s)
[355.827423] Starting dynamic subtest: uncore
[360.161924] Dynamic subtest uncore: SUCCESS (4.342s)
[360.171590] Starting dynamic subtest: workarounds
[377.796328] Dynamic subtest workarounds: FAIL (17.503s)
[377.804732] Starting dynamic subtest: gt_engines
[380.738552] Dynamic subtest gt_engines: SUCCESS (3.074s)
[380.749605] Starting dynamic subtest: gt_timelines
[395.762382] Dynamic subtest gt_timelines: SUCCESS (15.022s)
[395.771269] Starting dynamic subtest: gt_contexts
[400.080276] Dynamic subtest gt_contexts: SUCCESS (4.317s)
[400.097102] Starting dynamic subtest: gt_lrc
[404.495759] Dynamic subtest gt_lrc: SUCCESS (4.413s)
[404.504072] Starting dynamic subtest: gt_mocs
[407.534034] Dynamic subtest gt_mocs: SUCCESS (3.037s)
[407.544102] Starting dynamic subtest: gt_pm
[414.338168] Dynamic subtest gt_pm: SUCCESS (6.802s)
[414.347918] Starting dynamic subtest: gt_heartbeat
[418.620474] Dynamic subtest gt_heartbeat: SUCCESS (4.281s)
[418.630070] Starting dynamic subtest: gt_tlb
[427.933973] Dynamic subtest gt_tlb: SUCCESS (9.311s)
[427.944041] Starting dynamic subtest: requests
[439.445543] Dynamic subtest requests: SUCCESS (11.509s)
[439.455803] Starting dynamic subtest: migrate
[445.186576] Dynamic subtest migrate: SUCCESS (5.740s)
[445.196463] Starting dynamic subtest: active
[449.554032] Dynamic subtest active: SUCCESS (4.364s)
[449.563962] Starting dynamic subtest: objects
[452.697235] Dynamic subtest objects: SUCCESS (3.141s)
[452.706434] Starting dynamic subtest: mman
[457.485569] Dynamic subtest mman: SUCCESS (4.786s)
[457.495732] Starting dynamic subtest: dmabuf
[461.805753] Dynamic subtest dmabuf: SUCCESS (4.318s)
[461.820289] Starting dynamic subtest: vma
[464.468701] Dynamic subtest vma: SUCCESS (2.661s)
[464.482856] Starting dynamic subtest: coherency
[469.772204] Dynamic subtest coherency: SUCCESS (5.301s)
[469.781786] Starting dynamic subtest: gtt
[478.739553] Dynamic subtest gtt: SUCCESS (8.964s)
[478.749050] Starting dynamic subtest: gem
[486.548218] Dynamic subtest gem: SUCCESS (7.806s)
[486.558256] Starting dynamic subtest: evict
[491.895669] Dynamic subtest evict: SUCCESS (5.343s)
[491.905301] Starting dynamic subtest: hugepages
[502.593146] Dynamic subtest hugepages: SUCCESS (10.695s)
[502.603076] Starting dynamic subtest: gem_contexts
[530.882623] Dynamic subtest gem_contexts: SUCCESS (28.281s)
[530.892437] Starting dynamic subtest: client
[535.201749] Dynamic subtest client: SUCCESS (4.317s)
[535.216822] Starting dynamic subtest: gem_migrate
[539.507558] Dynamic subtest gem_migrate: SUCCESS (4.303s)
[539.517495] Starting dynamic subtest: reset
[542.298208] Dynamic subtest reset: SUCCESS (2.789s)
[542.311998] Starting dynamic subtest: memory_region
[546.613739] Dynamic subtest memory_region: SUCCESS (4.312s)
[546.623042] Starting dynamic subtest: hangcheck
[559.622632] Dynamic subtest hangcheck: SUCCESS (13.005s)
[559.630490] Starting dynamic subtest: execlists
[563.952555] Dynamic subtest execlists: SUCCESS (4.326s)
[563.962530] Starting dynamic subtest: ring_submission
[568.255219] Dynamic subtest ring_submission: SUCCESS (4.300s)
[568.266319] Starting dynamic subtest: perf
[571.012743] Dynamic subtest perf: SUCCESS (2.755s)
[571.027670] Starting dynamic subtest: slpc
[582.896751] Dynamic subtest slpc: SUCCESS (11.879s)
[582.906148] Starting dynamic subtest: guc
[586.696623] Dynamic subtest guc: SUCCESS (3.797s)
[586.706724] Starting dynamic subtest: guc_multi_lrc
[591.046130] Dynamic subtest guc_multi_lrc: SUCCESS (4.346s)
[591.055264] Starting dynamic subtest: guc_hang
[594.360140] Dynamic subtest guc_hang: SUCCESS (3.312s)
[594.370044] Starting dynamic subtest: late_gt_pm
[598.687408] Dynamic subtest late_gt_pm: SUCCESS (4.325s)
[598.690114] Subtest live: FAIL (247.159s)
[598.718628] [FACT i915_selftest (live)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[598.719346] [FACT i915_selftest (live)] deleted: kernel.kmod_is_loaded.i915: true
[598.722399] [044/133] (422s left) syncobj_wait (invalid-reset-bad-pad)
[600.193313] Starting subtest: invalid-reset-bad-pad
[600.195544] Subtest invalid-reset-bad-pad: SUCCESS (0.000s)
[600.287272] [FACT syncobj_wait (invalid-reset-bad-pad)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[600.288427] [FACT syncobj_wait (invalid-reset-bad-pad)] new: kernel.kmod_is_loaded.i915: true
[600.292061] [045/133] (420s left) api_intel_bb (lot-of-buffers)
[600.354145] Starting subtest: lot-of-buffers
[601.399845] Subtest lot-of-buffers: SUCCESS (1.046s)
[601.895881] [046/133] (419s left) kms_big_fb (4-tiled-64bpp-rotate-270)
[601.993423] Starting subtest: 4-tiled-64bpp-rotate-270
[602.026503] Subtest 4-tiled-64bpp-rotate-270: SKIP (0.032s)
[602.138414] [047/133] (418s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-0-hflip)
[602.224067] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-0-hflip
[602.228293] Subtest yf-tiled-max-hw-stride-32bpp-rotate-0-hflip: SKIP (0.000s)
[602.314428] [048/133] (418s left) kms_content_protection (uevent-hdcp14)
[602.434939] Starting subtest: uevent-hdcp14
[602.439421] Subtest uevent-hdcp14: SKIP (0.000s)
[602.549242] [049/133] (418s left) kms_psr (fbc-psr-suspend)
[602.631935] Starting subtest: fbc-psr-suspend
[602.634235] Starting dynamic subtest: eDP-1
[602.638338] Dynamic subtest eDP-1: SKIP (0.000s)
[602.642528] Subtest fbc-psr-suspend: SKIP (0.001s)
[602.722106] [050/133] (418s left) syncobj_wait (invalid-multi-wait-all-unsubmitted-signaled)
[602.777790] Starting subtest: invalid-multi-wait-all-unsubmitted-signaled
[602.780190] Subtest invalid-multi-wait-all-unsubmitted-signaled: SUCCESS (0.000s)
[602.894230] [051/133] (418s left) dmabuf_sync_file (export-wait-after-attach)
[602.939894] Starting subtest: export-wait-after-attach
[602.941960] Subtest export-wait-after-attach: SUCCESS (0.001s)
[603.010071] [052/133] (418s left) kms_big_fb (x-tiled-addfb-size-overflow)
[603.097080] Starting subtest: x-tiled-addfb-size-overflow
[603.099016] Subtest x-tiled-addfb-size-overflow: SUCCESS (0.000s)
[603.188516] [053/133] (418s left) syncobj_timeline (etime-single-wait-for-submit-unsubmitted)
[603.245844] Starting subtest: etime-single-wait-for-submit-unsubmitted
[603.345801] Subtest etime-single-wait-for-submit-unsubmitted: SUCCESS (0.101s)
[603.420387] [054/133] (417s left) kms_atomic (plane-primary-overlay-mutable-zpos)
[603.504147] Starting subtest: plane-primary-overlay-mutable-zpos
[606.913353] Subtest plane-primary-overlay-mutable-zpos: SKIP (3.399s)
[608.089617] [055/133] (413s left) vgem_basic (dmabuf-fence)
[608.134306] Starting subtest: dmabuf-fence
[608.136470] Subtest dmabuf-fence: SUCCESS (0.000s)
[608.190223] [056/133] (413s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-blt)
[608.268757] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-blt
[608.273013] Subtest fbc-2p-scndscrn-cur-indfb-draw-blt: SKIP (0.000s)
[608.374981] [057/133] (413s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-blt)
[608.444498] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-blt
[608.448819] Subtest fbc-2p-primscrn-spr-indfb-draw-blt: SKIP (0.000s)
[608.540401] [058/133] (412s left) gem_exec_schedule (u-submit-golden-slice)
[608.609047] Starting subtest: u-submit-golden-slice
[608.611400] Starting dynamic subtest: rcs0
[608.639898] Dynamic subtest rcs0: SUCCESS (0.038s)
[608.650278] Starting dynamic subtest: bcs0
[608.668057] Dynamic subtest bcs0: SUCCESS (0.028s)
[608.676865] Starting dynamic subtest: vcs0
[608.697062] Dynamic subtest vcs0: SUCCESS (0.028s)
[608.708976] Starting dynamic subtest: vcs1
[608.725448] Dynamic subtest vcs1: SUCCESS (0.028s)
[608.733635] Starting dynamic subtest: vecs0
[608.752024] Dynamic subtest vecs0: SUCCESS (0.026s)
[608.760456] Starting dynamic subtest: ccs0
[608.781210] Dynamic subtest ccs0: SUCCESS (0.028s)
[608.783473] Subtest u-submit-golden-slice: SUCCESS (0.180s)
[610.015410] [059/133] (411s left) gem_userptr_blits (coherency-sync)
[610.075641] Starting subtest: coherency-sync
[610.430957] Subtest coherency-sync: SKIP (0.323s)
[610.552525] [060/133] (410s left) kms_flip (dpms-vs-vblank-race)
[610.672369] Starting subtest: dpms-vs-vblank-race
[610.674616] Starting dynamic subtest: A-eDP1
[615.686211] Dynamic subtest A-eDP1: SUCCESS (5.013s)
[615.695113] Starting dynamic subtest: B-eDP1
[619.203384] Dynamic subtest B-eDP1: SUCCESS (3.517s)
[619.215349] Starting dynamic subtest: C-eDP1
[622.715653] Dynamic subtest C-eDP1: SUCCESS (3.508s)
[622.725685] Starting dynamic subtest: D-eDP1
[626.226379] Dynamic subtest D-eDP1: SUCCESS (3.510s)
[626.228850] Subtest dpms-vs-vblank-race: SUCCESS (15.559s)
[627.100874] [061/133] (394s left) kms_rotation_crc (primary-yf-tiled-reflect-x-270)
[627.185571] Starting subtest: primary-yf-tiled-reflect-x-270
[627.190042] Subtest primary-yf-tiled-reflect-x-270: SKIP (0.001s)
[627.273177] [062/133] (394s left) kms_plane_scaling (planes-downscale-factor-0-75-unity-scaling)
[627.345689] Starting subtest: planes-downscale-factor-0-75-unity-scaling
[627.347805] Starting dynamic subtest: pipe-A
[627.409717] Dynamic subtest pipe-A: SUCCESS (0.066s)
[627.420983] Starting dynamic subtest: pipe-B
[628.524216] Dynamic subtest pipe-B: SUCCESS (1.113s)
[628.535696] Starting dynamic subtest: pipe-C
[629.638460] Dynamic subtest pipe-C: SUCCESS (1.113s)
[629.647988] Starting dynamic subtest: pipe-D
[630.773611] Dynamic subtest pipe-D: SUCCESS (1.135s)
[630.775846] Subtest planes-downscale-factor-0-75-unity-scaling: SUCCESS (3.431s)
[631.932709] [063/133] (389s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling)
[632.013044] Starting subtest: flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling
[632.017307] Subtest flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling: SKIP (0.000s)
[632.087155] [064/133] (389s left) gem_render_copy (yf-tiled-to-vebox-x-tiled)
[632.149595] Starting subtest: yf-tiled-to-vebox-x-tiled
[632.153871] Subtest yf-tiled-to-vebox-x-tiled: SKIP (0.000s)
[632.334001] [065/133] (389s left) sysfs_heartbeat_interval (nopreempt)
[632.383220] Starting subtest: nopreempt
[632.385411] Starting dynamic subtest: vecs0
[641.932569] Dynamic subtest vecs0: SUCCESS (9.552s)
[641.944976] Starting dynamic subtest: ccs0
[645.932153] Dynamic subtest ccs0: SUCCESS (3.997s)
[645.943837] Starting dynamic subtest: vcs0
[655.889154] Dynamic subtest vcs0: SUCCESS (9.955s)
[655.901340] Starting dynamic subtest: bcs0
[659.827012] Dynamic subtest bcs0: SUCCESS (3.937s)
[659.838977] Starting dynamic subtest: rcs0
[663.882866] Dynamic subtest rcs0: SUCCESS (4.055s)
[663.894888] Starting dynamic subtest: vcs1
[673.936233] Dynamic subtest vcs1: SUCCESS (10.051s)
[673.938767] Subtest nopreempt: SUCCESS (41.558s)
[674.014507] [066/133] (347s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-render)
[674.089034] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-render
[681.172116] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-render: SUCCESS (7.085s)
[681.327440] [067/133] (340s left) kms_color (ctm-blue-to-red)
[681.409858] Starting subtest: ctm-blue-to-red
[681.412012] Starting dynamic subtest: pipe-A-eDP-1
[682.123921] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.715s)
[682.133705] Starting dynamic subtest: pipe-B-eDP-1
[683.552972] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.429s)
[683.568774] Starting dynamic subtest: pipe-C-eDP-1
[684.940726] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.387s)
[684.950318] Starting dynamic subtest: pipe-D-eDP-1
[686.247577] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.307s)
[686.249981] Subtest ctm-blue-to-red: SUCCESS (4.841s)
[687.078307] [068/133] (334s left) kms_ccs (bad-aux-stride-4-tiled-mtl-rc-ccs-cc)
[687.156263] Starting subtest: bad-aux-stride-4-tiled-mtl-rc-ccs-cc
[687.158592] Starting dynamic subtest: pipe-A-eDP-1
[687.178871] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[687.191147] Starting dynamic subtest: pipe-B-eDP-1
[687.210498] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[687.219469] Starting dynamic subtest: pipe-C-eDP-1
[687.238923] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[687.247803] Starting dynamic subtest: pipe-D-eDP-1
[687.267110] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[687.269318] Subtest bad-aux-stride-4-tiled-mtl-rc-ccs-cc: SUCCESS (0.007s)
[689.353941] [069/133] (332s left) gem_create (create-ext-set-pat)
[689.524224] Starting subtest: create-ext-set-pat
[689.526410] Subtest create-ext-set-pat: SUCCESS (0.001s)
[689.635902] [070/133] (332s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-onoff)
[689.721628] Starting subtest: psr-2p-scndscrn-spr-indfb-onoff
[689.725943] Subtest psr-2p-scndscrn-spr-indfb-onoff: SKIP (0.000s)
[689.828516] [071/133] (332s left) kms_ccs (crc-primary-basic-4-tiled-dg2-mc-ccs)
[689.916471] Starting subtest: crc-primary-basic-4-tiled-dg2-mc-ccs
[689.918734] Starting dynamic subtest: pipe-A-eDP-1
[689.942900] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[689.955816] Starting dynamic subtest: pipe-B-eDP-1
[689.977764] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[689.986479] Starting dynamic subtest: pipe-C-eDP-1
[690.008390] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[690.017287] Starting dynamic subtest: pipe-D-eDP-1
[690.040308] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[690.044391] Subtest crc-primary-basic-4-tiled-dg2-mc-ccs: SKIP (0.005s)
[692.216489] [072/133] (329s left) kms_atomic_transition (plane-all-modeset-transition-fencing)
[692.291443] Starting subtest: plane-all-modeset-transition-fencing
[692.296034] Subtest plane-all-modeset-transition-fencing: SKIP (0.000s)
[692.375011] [073/133] (329s left) gem_ctx_bad_destroy (double-destroy)
[692.429431] Starting subtest: double-destroy
[692.431918] Subtest double-destroy: SUCCESS (0.000s)
[692.505325] [074/133] (329s left) kms_flip_scaled_crc (flip-32bpp-yftile-to-64bpp-yftile-upscaling)
[692.586912] Starting subtest: flip-32bpp-yftile-to-64bpp-yftile-upscaling
[692.591386] Subtest flip-32bpp-yftile-to-64bpp-yftile-upscaling: SKIP (0.000s)
[692.662121] [075/133] (329s left) prime_vgem (basic-fence-flip)
[692.744159] Starting subtest: basic-fence-flip
[693.025709] Subtest basic-fence-flip: SUCCESS (0.283s)
[693.132672] [076/133] (329s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-indfb-plflip-blt)
[693.204155] Starting subtest: fbcpsr-2p-primscrn-indfb-plflip-blt
[693.208241] Subtest fbcpsr-2p-primscrn-indfb-plflip-blt: SKIP (0.000s)
[693.298293] [077/133] (328s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-render)
[693.386115] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-render
[693.390485] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-render: SKIP (0.000s)
[693.479292] [078/133] (328s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-shrfb-draw-mmap-gtt)
[693.553795] Starting subtest: fbc-1p-offscreen-pri-shrfb-draw-mmap-gtt
[693.557978] Subtest fbc-1p-offscreen-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[693.644278] [079/133] (328s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-mmap-wc)
[693.719429] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-mmap-wc
[700.771776] Subtest psr-1p-primscrn-pri-shrfb-draw-mmap-wc: SUCCESS (7.057s)
[700.884423] [080/133] (321s left) kms_rotation_crc (sprite-rotation-90)
[700.962416] Starting subtest: sprite-rotation-90
[700.966810] Subtest sprite-rotation-90: SKIP (0.001s)
[701.032499] [081/133] (321s left) kms_plane (plane-position-hole)
[701.101782] Starting subtest: plane-position-hole
[701.594144] Starting dynamic subtest: pipe-A-plane-1
[702.901604] Dynamic subtest pipe-A-plane-1: SUCCESS (1.306s)
[702.911965] Starting dynamic subtest: pipe-A-plane-2
[704.204535] Dynamic subtest pipe-A-plane-2: SUCCESS (1.304s)
[704.216587] Starting dynamic subtest: pipe-A-plane-3
[705.483558] Dynamic subtest pipe-A-plane-3: SUCCESS (1.277s)
[705.494117] Starting dynamic subtest: pipe-A-plane-4
[706.713319] Dynamic subtest pipe-A-plane-4: SUCCESS (1.227s)
[706.728941] Starting dynamic subtest: pipe-A-plane-5
[706.738846] Dynamic subtest pipe-A-plane-5: SUCCESS (0.026s)
[707.859000] Starting dynamic subtest: pipe-B-plane-1
[709.098604] Dynamic subtest pipe-B-plane-1: SUCCESS (1.246s)
[709.108868] Starting dynamic subtest: pipe-B-plane-2
[710.332762] Dynamic subtest pipe-B-plane-2: SUCCESS (1.234s)
[710.343117] Starting dynamic subtest: pipe-B-plane-3
[711.569735] Dynamic subtest pipe-B-plane-3: SUCCESS (1.238s)
[711.579801] Starting dynamic subtest: pipe-B-plane-4
[712.819325] Dynamic subtest pipe-B-plane-4: SUCCESS (1.248s)
[712.830002] Starting dynamic subtest: pipe-B-plane-5
[712.844534] Dynamic subtest pipe-B-plane-5: SUCCESS (0.024s)
[712.846833] Subtest plane-position-hole: SUCCESS (11.743s)
[713.694457] [082/133] (308s left) gem_softpin (safe-alignment)
[713.767565] Starting subtest: safe-alignment
[713.792290] Subtest safe-alignment: SUCCESS (0.025s)
[714.934304] [083/133] (307s left) kms_psr (psr2-primary-mmap-cpu)
[715.013486] Starting subtest: psr2-primary-mmap-cpu
[715.015686] Starting dynamic subtest: eDP-1
[716.790395] Dynamic subtest eDP-1: SUCCESS (1.776s)
[716.792684] Subtest psr2-primary-mmap-cpu: SUCCESS (1.777s)
[717.659375] [084/133] (304s left) kms_vrr (flip-basic-fastset)
[717.728000] Starting subtest: flip-basic-fastset
[717.734271] Subtest flip-basic-fastset: SKIP (0.000s)
[717.799015] [085/133] (304s left) kms_pm_dc (dc6-dpms)
[718.901314] Starting subtest: dc6-dpms
[720.941565] Subtest dc6-dpms: SUCCESS (2.041s)
[721.016925] [086/133] (301s left) kms_cursor_legacy (2x-flip-vs-cursor-legacy)
[721.119452] Starting subtest: 2x-flip-vs-cursor-legacy
[721.123922] Subtest 2x-flip-vs-cursor-legacy: SKIP (0.001s)
[721.270309] [087/133] (301s left) fbdev (pan)
[721.307462] Starting subtest: pan
[721.336027] Subtest pan: SUCCESS (0.031s)
[721.419343] [088/133] (301s left) kms_frontbuffer_tracking (fbcpsr-indfb-scaledprimary)
[721.504814] Starting subtest: fbcpsr-indfb-scaledprimary
[727.265687] Subtest fbcpsr-indfb-scaledprimary: SUCCESS (5.764s)
[727.387476] [089/133] (295s left) gem_huc_copy (huc-copy)
[727.463124] Starting subtest: huc-copy
[727.465487] Subtest huc-copy: SUCCESS (0.004s)
[727.588956] [090/133] (295s left) gem_exec_reloc (basic-wc-gtt-active)
[727.653773] Subtest basic-wc-gtt-active: SKIP (0.000s)
[727.729990] [091/133] (295s left) syncobj_wait (multi-wait-all-for-submit-unsubmitted)
[727.788991] Starting subtest: multi-wait-all-for-submit-unsubmitted
[727.891215] Subtest multi-wait-all-for-submit-unsubmitted: SUCCESS (0.101s)
[727.984622] [092/133] (294s left) kms_ccs (crc-primary-suspend-y-tiled-ccs)
[728.050371] Starting subtest: crc-primary-suspend-y-tiled-ccs
[728.052907] Starting dynamic subtest: pipe-A-eDP-1
[728.062262] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[728.072919] Starting dynamic subtest: pipe-B-eDP-1
[728.081658] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[728.090760] Starting dynamic subtest: pipe-C-eDP-1
[728.099219] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[728.108806] Starting dynamic subtest: pipe-D-eDP-1
[728.117048] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[728.121014] Subtest crc-primary-suspend-y-tiled-ccs: SKIP (0.004s)
[730.286931] [093/133] (292s left) kms_cursor_crc (cursor-tearing-framebuffer-change)
[730.381917] Starting subtest: cursor-tearing-framebuffer-change
[730.384150] Starting dynamic subtest: pipe-A-eDP-1
[730.953817] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.569s)
[730.970233] Starting dynamic subtest: pipe-D-eDP-1
[732.210584] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.255s)
[732.212493] Subtest cursor-tearing-framebuffer-change: SUCCESS (1.827s)
[733.057938] [094/133] (289s left) kms_cursor_crc (cursor-rapid-movement-32x32)
[733.186884] Starting subtest: cursor-rapid-movement-32x32
[733.231025] Subtest cursor-rapid-movement-32x32: SKIP (0.041s)
[733.533890] [095/133] (289s left) kms_frontbuffer_tracking (psr-2p-primscrn-indfb-msflip-blt)
[733.615525] Starting subtest: psr-2p-primscrn-indfb-msflip-blt
[733.619867] Subtest psr-2p-primscrn-indfb-msflip-blt: SKIP (0.000s)
[733.713445] [096/133] (289s left) api_intel_allocator (standalone)
[733.771860] Starting subtest: standalone
[733.802126] Subtest standalone: SUCCESS (0.031s)
[733.933315] [097/133] (289s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-pwrite)
[734.022668] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-pwrite
[742.725767] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-pwrite: SUCCESS (8.705s)
[742.844783] [098/133] (280s left) kms_fb_coherency (memset-crc)
[742.925861] Starting subtest: memset-crc
[742.927770] Starting dynamic subtest: mmap-offset-wc
[743.283896] Dynamic subtest mmap-offset-wc: SUCCESS (0.357s)
[743.584468] Starting dynamic subtest: mmap-offset-uc
[749.745959] Dynamic subtest mmap-offset-uc: SUCCESS (6.169s)
[750.036531] Subtest memset-crc: SUCCESS (7.111s)
[750.899794] [099/133] (272s left) perf (disabled-read-error)
[751.040249] Starting subtest: disabled-read-error
[751.055097] Subtest disabled-read-error: SUCCESS (0.017s)
[751.098076] [100/133] (272s left) kms_frontbuffer_tracking (fbcpsr-slowdraw)
[751.217235] Starting subtest: fbcpsr-slowdraw
[776.329044] Subtest fbcpsr-slowdraw: SUCCESS (25.114s)
[776.465621] [101/133] (246s left) syncobj_timeline (wait-all-delayed-signal)
[776.535857] Starting subtest: wait-all-delayed-signal
[776.637694] Subtest wait-all-delayed-signal: SUCCESS (0.102s)
[776.725417] [102/133] (246s left) kms_plane_multiple (tiling-yf)
[776.809493] Starting subtest: tiling-yf
[776.813633] Subtest tiling-yf: SKIP (0.000s)
[776.884557] [103/133] (246s left) kms_ccs (bad-pixel-format-4-tiled-dg2-mc-ccs)
[776.967016] Starting subtest: bad-pixel-format-4-tiled-dg2-mc-ccs
[776.969261] Starting dynamic subtest: pipe-A-eDP-1
[776.991380] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[777.002750] Starting dynamic subtest: pipe-B-eDP-1
[777.023449] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[777.033919] Starting dynamic subtest: pipe-C-eDP-1
[777.054784] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[777.064252] Starting dynamic subtest: pipe-D-eDP-1
[777.086617] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[777.090759] Subtest bad-pixel-format-4-tiled-dg2-mc-ccs: SKIP (0.004s)
[779.121234] [104/133] (244s left) kms_sequence (queue-busy)
[779.197117] Starting subtest: queue-busy
[779.199454] Starting dynamic subtest: pipe-A-eDP-1
[781.135481] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.935s)
[781.146416] Starting dynamic subtest: pipe-B-eDP-1
[783.723580] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.588s)
[783.733700] Starting dynamic subtest: pipe-C-eDP-1
[786.327319] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.602s)
[786.337833] Starting dynamic subtest: pipe-D-eDP-1
[788.960256] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.630s)
[788.962390] Subtest queue-busy: SUCCESS (9.761s)
[789.752069] [105/133] (233s left) gem_mmap_gtt (big-copy-xy)
[789.813926] Subtest big-copy-XY: SKIP (0.000s)
[789.870931] [106/133] (233s left) prime_vgem (shrink)
[789.947569] Starting subtest: shrink
[789.960984] Subtest shrink: SUCCESS (0.013s)
[790.079111] [107/133] (233s left) gem_eio (create)
[790.312033] Starting subtest: create
[790.650269] Subtest create: SUCCESS (0.338s)
[790.775632] [108/133] (232s left) kms_atomic_transition (plane-use-after-nonblocking-unbind-fencing)
[790.848566] Starting subtest: plane-use-after-nonblocking-unbind-fencing
[790.850553] Starting dynamic subtest: pipe-A-eDP-1
[790.910531] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.062s)
[791.224424] Starting dynamic subtest: pipe-B-eDP-1
[792.058691] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.846s)
[792.348601] Subtest plane-use-after-nonblocking-unbind-fencing: SUCCESS (1.498s)
[793.224469] [109/133] (230s left) kms_fbcon_fbt (psr)
[793.272757] Starting subtest: psr
[800.557113] Subtest psr: SUCCESS (7.280s)
[800.634670] [110/133] (222s left) gem_close_race (basic-threads)
[800.694998] Starting subtest: basic-threads
[802.033312] Subtest basic-threads: SUCCESS (1.338s)
[802.230745] [111/133] (221s left) gem_exec_gttfill (engines)
[802.289208] Starting subtest: engines
[802.291094] Starting dynamic subtest: rcs0
[825.215582] Dynamic subtest rcs0: SUCCESS (22.926s)
[825.229815] Starting dynamic subtest: bcs0
[848.588586] Dynamic subtest bcs0: SUCCESS (23.369s)
[848.598627] Starting dynamic subtest: vcs0
[871.922164] Dynamic subtest vcs0: SUCCESS (23.329s)
[871.937505] Starting dynamic subtest: vcs1
[895.315646] Dynamic subtest vcs1: SUCCESS (23.387s)
[895.333017] Starting dynamic subtest: vecs0
[918.716270] Dynamic subtest vecs0: SUCCESS (23.393s)
[918.728900] Starting dynamic subtest: ccs0
[942.169960] Dynamic subtest ccs0: SUCCESS (23.447s)
[942.172722] Subtest engines: SUCCESS (139.865s)
[942.365754] [112/133] ( 81s left) gem_partial_pwrite_pread (writes-after-reads)
[942.484745] Subtest writes-after-reads: SKIP (0.000s)
[942.547081] [113/133] ( 81s left) kms_rotation_crc (sprite-rotation-180)
[942.640401] Starting subtest: sprite-rotation-180
[949.509838] Subtest sprite-rotation-180: SUCCESS (6.870s)
[950.653865] [114/133] ( 73s left) i915_drm_fdinfo (most-busy-check-all)
[950.699415] Starting subtest: most-busy-check-all
[950.701696] Starting dynamic subtest: rcs0
[950.706391] Dynamic subtest rcs0: SKIP (0.004s)
[950.716488] Starting dynamic subtest: bcs0
[950.720962] Dynamic subtest bcs0: SKIP (0.000s)
[950.730626] Starting dynamic subtest: vcs0
[950.735146] Dynamic subtest vcs0: SKIP (0.000s)
[950.745284] Starting dynamic subtest: vcs1
[950.749468] Dynamic subtest vcs1: SKIP (0.000s)
[950.759401] Starting dynamic subtest: vecs0
[950.763862] Dynamic subtest vecs0: SKIP (0.000s)
[950.773373] Starting dynamic subtest: ccs0
[950.777806] Dynamic subtest ccs0: SKIP (0.000s)
[950.782299] Subtest most-busy-check-all: SKIP (0.010s)
[950.819515] [115/133] ( 72s left) gem_exec_params (dr4-dirt)
[950.895433] Starting subtest: DR4-dirt
[950.897641] Subtest DR4-dirt: SUCCESS (0.000s)
[951.008409] [116/133] ( 72s left) kms_plane (pixel-format-y-tiled-gen12-rc-ccs-modifier)
[951.089667] Starting subtest: pixel-format-y-tiled-gen12-rc-ccs-modifier
[951.094005] Subtest pixel-format-y-tiled-gen12-rc-ccs-modifier: SKIP (0.000s)
[951.198454] [117/133] ( 72s left) gem_exec_flush (basic-wb-ro-default)
[951.248869] Starting subtest: basic-wb-ro-default
[956.706265] Subtest basic-wb-ro-default: SUCCESS (5.457s)
[956.902404] [118/133] ( 67s left) gem_exec_flush (basic-wb-pro-default)
[956.956155] Starting subtest: basic-wb-pro-default
[962.434510] Subtest basic-wb-pro-default: SUCCESS (5.478s)
[962.624822] [119/133] ( 61s left) kms_cursor_crc (cursor-alpha-transparent)
[962.712213] Starting subtest: cursor-alpha-transparent
[962.714553] Starting dynamic subtest: pipe-A-eDP-1
[963.353676] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.641s)
[963.363797] Starting dynamic subtest: pipe-D-eDP-1
[964.648902] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.294s)
[964.651220] Subtest cursor-alpha-transparent: SUCCESS (1.938s)
[965.527308] [120/133] ( 58s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-pwrite)
[965.613985] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-pwrite
[970.982200] Subtest fbc-1p-primscrn-pri-indfb-draw-pwrite: SUCCESS (5.370s)
[972.125057] [121/133] ( 51s left) kms_chamelium_edid (dp-edid-change-during-suspend)
[972.498203] Subtest dp-edid-change-during-suspend: SKIP (0.000s)
[973.326716] [122/133] ( 50s left) kms_big_fb (x-tiled-64bpp-rotate-180)
[973.403014] Starting subtest: x-tiled-64bpp-rotate-180
[975.060973] Subtest x-tiled-64bpp-rotate-180: SUCCESS (1.658s)
[975.237851] [123/133] ( 48s left) gem_exec_params (rel-constants-invalid-rel-gen5)
[975.293375] Starting subtest: rel-constants-invalid-rel-gen5
[975.295869] Subtest rel-constants-invalid-rel-gen5: SUCCESS (0.000s)
[975.395298] [124/133] ( 48s left) kms_psr2_sf (psr2-overlay-plane-move-continuous-exceed-fully-sf)
[975.480259] Starting subtest: psr2-overlay-plane-move-continuous-exceed-fully-sf
[975.482609] Starting dynamic subtest: pipe-A-eDP-1
[991.974408] Dynamic subtest pipe-A-eDP-1: SUCCESS (16.496s)
[991.985502] Starting dynamic subtest: pipe-B-eDP-1
[1009.132449] Dynamic subtest pipe-B-eDP-1: SUCCESS (17.154s)
[1009.134891] Subtest psr2-overlay-plane-move-continuous-exceed-fully-sf: SUCCESS (33.654s)
[1009.931803] [125/133] ( 14s left) kms_pipe_crc_basic (nonblocking-crc)
[1010.006446] Starting subtest: nonblocking-crc
[1010.008695] Starting dynamic subtest: pipe-A-eDP-1
[1010.742319] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.735s)
[1010.756628] Starting dynamic subtest: pipe-B-eDP-1
[1012.132027] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.390s)
[1012.144363] Starting dynamic subtest: pipe-C-eDP-1
[1013.544453] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.410s)
[1013.555250] Starting dynamic subtest: pipe-D-eDP-1
[1014.870220] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.323s)
[1014.872760] Subtest nonblocking-crc: SUCCESS (4.864s)
[1015.682620] [126/133] (  8s left) gem_exec_balancer (indices)
[1015.738486] Starting subtest: indices
[1017.901298] Subtest indices: SUCCESS (2.160s)
[1018.201334] [127/133] (  6s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-0-async-flip)
[1018.292480] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-0-async-flip
[1019.105711] Subtest 4-tiled-max-hw-stride-64bpp-rotate-0-async-flip: SUCCESS (0.815s)
[1019.258270] [128/133] (  5s left) syncobj_timeline (multi-wait-for-submit-available-submitted-signaled)
[1019.312460] Starting subtest: multi-wait-for-submit-available-submitted-signaled
[1019.314675] Subtest multi-wait-for-submit-available-submitted-signaled: SUCCESS (0.000s)
[1019.386021] [129/133] (  5s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-mmap-cpu)
[1019.461996] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-mmap-cpu
[1019.466458] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[1019.570342] [130/133] (  4s left) gem_pxp (regular-baseline-src-copy-readible)
[1019.693220] Starting subtest: regular-baseline-src-copy-readible
[1019.750379] Subtest regular-baseline-src-copy-readible: SUCCESS (0.059s)
[1019.872444] [131/133] (  4s left) gem_exec_schedule (submit-late-slice)
[1019.931780] Starting subtest: submit-late-slice
[1019.933693] Starting dynamic subtest: rcs0
[1019.963926] Dynamic subtest rcs0: SUCCESS (0.040s)
[1019.976811] Starting dynamic subtest: bcs0
[1019.999887] Dynamic subtest bcs0: SUCCESS (0.035s)
[1020.009639] Starting dynamic subtest: vcs0
[1020.033594] Dynamic subtest vcs0: SUCCESS (0.033s)
[1020.043302] Starting dynamic subtest: vcs1
[1020.066866] Dynamic subtest vcs1: SUCCESS (0.033s)
[1020.076643] Starting dynamic subtest: vecs0
[1020.099458] Dynamic subtest vecs0: SUCCESS (0.032s)
[1020.108972] Starting dynamic subtest: ccs0
[1020.141081] Dynamic subtest ccs0: SUCCESS (0.041s)
[1020.143111] Subtest submit-late-slice: SUCCESS (0.218s)
[1022.005316] [132/133] (  2s left) gem_exec_fence (long-history)
[1022.482985] Starting subtest: long-history
[1029.616100] Subtest long-history: SUCCESS (7.132s)
[1030.388367] Overall timeout time exceeded, stopping.
[1030.405441] Closing watchdogs
results: parsing output: 0/ for test: kms_frontbuffer_tracking
results: parsing output: 1/ for test: vgem_basic
results: parsing output: 2/ for test: kms_frontbuffer_tracking
results: parsing output: 3/ for test: gem_madvise
results: parsing output: 4/ for test: kms_async_flips
results: parsing output: 5/ for test: perf_pmu
results: parsing output: 6/ for test: syncobj_timeline
results: parsing output: 7/ for test: kms_chamelium_hpd
results: parsing output: 8/ for test: perf_pmu
results: parsing output: 9/ for test: gem_ctx_persistence
results: parsing output: 10/ for test: kms_frontbuffer_tracking
results: parsing output: 11/ for test: gem_exec_schedule
results: parsing output: 12/ for test: gem_mmap_gtt
results: parsing output: 13/ for test: gem_mmap_offset
results: parsing output: 14/ for test: kms_ccs
results: parsing output: 15/ for test: kms_psr
results: parsing output: 16/ for test: kms_frontbuffer_tracking
results: parsing output: 17/ for test: gem_vm_create
results: parsing output: 18/ for test: kms_hdr
results: parsing output: 19/ for test: gem_exec_balancer
results: parsing output: 20/ for test: kms_chamelium_audio
results: parsing output: 21/ for test: kms_pm_rpm
results: parsing output: 22/ for test: kms_prop_blob
results: parsing output: 23/ for test: gem_ctx_param
results: parsing output: 24/ for test: kms_big_fb
results: parsing output: 25/ for test: gem_reg_read
results: parsing output: 26/ for test: kms_addfb_basic
results: parsing output: 27/ for test: syncobj_timeline
results: parsing output: 28/ for test: i915_pm_freq_api
results: parsing output: 29/ for test: kms_addfb_basic
results: parsing output: 30/ for test: i915_pm_rpm
results: parsing output: 31/ for test: gem_mmap_gtt
results: parsing output: 32/ for test: gem_exec_reloc
results: parsing output: 33/ for test: kms_frontbuffer_tracking
results: parsing output: 34/ for test: kms_dp_link_training
results: parsing output: 35/ for test: sw_sync
results: parsing output: 36/ for test: kms_psr2_sf
results: parsing output: 37/ for test: kms_lease
results: parsing output: 38/ for test: kms_frontbuffer_tracking
results: parsing output: 39/ for test: kms_psr
results: parsing output: 40/ for test: gen9_exec_parse
results: parsing output: 41/ for test: kms_scaling_modes
results: parsing output: 42/ for test: i915_selftest
results: parsing output: 43/ for test: syncobj_wait
results: parsing output: 44/ for test: api_intel_bb
results: parsing output: 45/ for test: kms_big_fb
results: parsing output: 46/ for test: kms_big_fb
results: parsing output: 47/ for test: kms_content_protection
results: parsing output: 48/ for test: kms_psr
results: parsing output: 49/ for test: syncobj_wait
results: parsing output: 50/ for test: dmabuf_sync_file
results: parsing output: 51/ for test: kms_big_fb
results: parsing output: 52/ for test: syncobj_timeline
results: parsing output: 53/ for test: kms_atomic
results: parsing output: 54/ for test: vgem_basic
results: parsing output: 55/ for test: kms_frontbuffer_tracking
results: parsing output: 56/ for test: kms_frontbuffer_tracking
results: parsing output: 57/ for test: gem_exec_schedule
results: parsing output: 58/ for test: gem_userptr_blits
results: parsing output: 59/ for test: kms_flip
results: parsing output: 60/ for test: kms_rotation_crc
results: parsing output: 61/ for test: kms_plane_scaling
results: parsing output: 62/ for test: kms_flip_scaled_crc
results: parsing output: 63/ for test: gem_render_copy
results: parsing output: 64/ for test: sysfs_heartbeat_interval
results: parsing output: 65/ for test: kms_frontbuffer_tracking
results: parsing output: 66/ for test: kms_color
results: parsing output: 67/ for test: kms_ccs
results: parsing output: 68/ for test: gem_create
results: parsing output: 69/ for test: kms_frontbuffer_tracking
results: parsing output: 70/ for test: kms_ccs
results: parsing output: 71/ for test: kms_atomic_transition
results: parsing output: 72/ for test: gem_ctx_bad_destroy
results: parsing output: 73/ for test: kms_flip_scaled_crc
results: parsing output: 74/ for test: prime_vgem
results: parsing output: 75/ for test: kms_frontbuffer_tracking
results: parsing output: 76/ for test: kms_frontbuffer_tracking
results: parsing output: 77/ for test: kms_frontbuffer_tracking
results: parsing output: 78/ for test: kms_frontbuffer_tracking
results: parsing output: 79/ for test: kms_rotation_crc
results: parsing output: 80/ for test: kms_plane
results: parsing output: 81/ for test: gem_softpin
results: parsing output: 82/ for test: kms_psr
results: parsing output: 83/ for test: kms_vrr
results: parsing output: 84/ for test: kms_pm_dc
results: parsing output: 85/ for test: kms_cursor_legacy
results: parsing output: 86/ for test: fbdev
results: parsing output: 87/ for test: kms_frontbuffer_tracking
results: parsing output: 88/ for test: gem_huc_copy
results: parsing output: 89/ for test: gem_exec_reloc
results: parsing output: 90/ for test: syncobj_wait
results: parsing output: 91/ for test: kms_ccs
results: parsing output: 92/ for test: kms_cursor_crc
results: parsing output: 93/ for test: kms_cursor_crc
results: parsing output: 94/ for test: kms_frontbuffer_tracking
results: parsing output: 95/ for test: api_intel_allocator
results: parsing output: 96/ for test: kms_frontbuffer_tracking
results: parsing output: 97/ for test: kms_fb_coherency
results: parsing output: 98/ for test: perf
results: parsing output: 99/ for test: kms_frontbuffer_tracking
results: parsing output: 100/ for test: syncobj_timeline
results: parsing output: 101/ for test: kms_plane_multiple
results: parsing output: 102/ for test: kms_ccs
results: parsing output: 103/ for test: kms_sequence
results: parsing output: 104/ for test: gem_mmap_gtt
results: parsing output: 105/ for test: prime_vgem
results: parsing output: 106/ for test: gem_eio
results: parsing output: 107/ for test: kms_atomic_transition
results: parsing output: 108/ for test: kms_fbcon_fbt
results: parsing output: 109/ for test: gem_close_race
results: parsing output: 110/ for test: gem_exec_gttfill
results: parsing output: 111/ for test: gem_partial_pwrite_pread
results: parsing output: 112/ for test: kms_rotation_crc
results: parsing output: 113/ for test: i915_drm_fdinfo
results: parsing output: 114/ for test: gem_exec_params
results: parsing output: 115/ for test: kms_plane
results: parsing output: 116/ for test: gem_exec_flush
results: parsing output: 117/ for test: gem_exec_flush
results: parsing output: 118/ for test: kms_cursor_crc
results: parsing output: 119/ for test: kms_frontbuffer_tracking
results: parsing output: 120/ for test: kms_chamelium_edid
results: parsing output: 121/ for test: kms_big_fb
results: parsing output: 122/ for test: gem_exec_params
results: parsing output: 123/ for test: kms_psr2_sf
results: parsing output: 124/ for test: kms_pipe_crc_basic
results: parsing output: 125/ for test: gem_exec_balancer
results: parsing output: 126/ for test: kms_big_fb
results: parsing output: 127/ for test: syncobj_timeline
results: parsing output: 128/ for test: kms_frontbuffer_tracking
results: parsing output: 129/ for test: gem_pxp
results: parsing output: 130/ for test: gem_exec_schedule
results: parsing output: 131/ for test: gem_exec_fence
results: parsing output: 132/ for test: gem_mmap_wc
results: no output, setting notrun
Done.