[58.952764] Initializing watchdogs
[58.952860]   /dev/watchdog0
[58.966872] [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]
[58.970923] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[58.973158] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[58.976535] [001/131] (960s left) gem_mmap_gtt (big-bo)
[59.067369] Subtest big-bo: SKIP (0.000s)
[59.149658] [002/131] (960s left) kms_frontbuffer_tracking (fbcpsr-1p-pri-indfb-multidraw)
[59.255463] Starting subtest: fbcpsr-1p-pri-indfb-multidraw
[81.581949] Subtest fbcpsr-1p-pri-indfb-multidraw: SUCCESS (22.354s)
[81.733100] [003/131] (937s left) gem_ppgtt (blt-vs-render-ctxn)
[81.792136] Starting subtest: blt-vs-render-ctxN
[114.725447] Subtest blt-vs-render-ctxN: SUCCESS (32.930s)
[114.895539] [004/131] (904s left) gem_wait (write-busy)
[115.002639] Starting subtest: write-busy
[115.005034] Starting dynamic subtest: all-engines
[115.713380] Dynamic subtest all-engines: SUCCESS (0.711s)
[115.728636] Starting dynamic subtest: rcs0
[116.263879] Dynamic subtest rcs0: SUCCESS (0.549s)
[116.277026] Starting dynamic subtest: bcs0
[116.812149] Dynamic subtest bcs0: SUCCESS (0.548s)
[116.826936] Starting dynamic subtest: vcs0
[117.909109] Dynamic subtest vcs0: SUCCESS (1.095s)
[117.923842] Starting dynamic subtest: vcs1
[119.894373] Dynamic subtest vcs1: SUCCESS (1.983s)
[119.908455] Starting dynamic subtest: vecs0
[121.878652] Dynamic subtest vecs0: SUCCESS (1.982s)
[121.892033] Starting dynamic subtest: ccs0
[122.428762] Dynamic subtest ccs0: SUCCESS (0.549s)
[122.431436] Subtest write-busy: SUCCESS (7.426s)
[122.644797] [FACT gem_wait (write-busy)] new: kernel.kmod_is_loaded.vgem: true
[122.647899] [005/131] (896s left) kms_lease (atomic-implicit-crtc)
[122.758846] Starting subtest: atomic-implicit-crtc
[122.761217] Starting dynamic subtest: pipe-A-eDP-1
[122.772253] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.002s)
[122.779979] Starting dynamic subtest: pipe-B-eDP-1
[122.791404] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.009s)
[122.798631] Starting dynamic subtest: pipe-C-eDP-1
[122.809432] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.009s)
[122.817067] Starting dynamic subtest: pipe-D-eDP-1
[122.828343] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.009s)
[122.830518] Subtest atomic-implicit-crtc: SUCCESS (0.032s)
[122.930250] [006/131] (896s left) i915_pm_freq_api (freq-reset)
[122.995669] Starting subtest: freq-reset
[122.998049] Starting dynamic subtest: gt0
[123.175724] Dynamic subtest gt0: SUCCESS (0.179s)
[123.184830] Starting dynamic subtest: gt1
[123.335788] Dynamic subtest gt1: SUCCESS (0.156s)
[123.338319] Subtest freq-reset: SUCCESS (0.336s)
[123.435942] [007/131] (896s left) kms_cursor_legacy (cursora-vs-flipa-legacy)
[123.549076] Starting subtest: cursorA-vs-flipA-legacy
[134.724031] Subtest cursorA-vs-flipA-legacy: SUCCESS (11.174s)
[135.616941] [008/131] (884s left) gem_mmap_gtt (cpuset-medium-copy-xy)
[135.669769] Subtest cpuset-medium-copy-XY: SKIP (0.000s)
[135.738893] [009/131] (884s left) i915_drm_fdinfo (memory-info-purgeable)
[135.777069] Starting subtest: memory-info-purgeable
[135.779344] Starting dynamic subtest: smem0
[138.331041] Dynamic subtest smem0: SUCCESS (2.555s)
[138.333365] Subtest memory-info-purgeable: SUCCESS (2.556s)
[138.427258] [010/131] (881s left) gem_partial_pwrite_pread (write)
[138.486697] Subtest write: SKIP (0.000s)
[138.570480] [011/131] (881s left) gem_ctx_exec (basic-invalid-context)
[138.629380] Starting subtest: basic-invalid-context
[138.636381] Subtest basic-invalid-context: SUCCESS (0.008s)
[138.759599] [012/131] (881s left) kms_atomic_transition (plane-toggle-modeset-transition)
[138.860120] Starting subtest: plane-toggle-modeset-transition
[138.861939] Starting dynamic subtest: pipe-A-eDP-1
[151.516615] Dynamic subtest pipe-A-eDP-1: SUCCESS (12.655s)
[151.526470] Starting dynamic subtest: pipe-B-eDP-1
[163.910082] Dynamic subtest pipe-B-eDP-1: SUCCESS (12.390s)
[163.912916] Subtest plane-toggle-modeset-transition: SUCCESS (25.050s)
[164.738699] [013/131] (855s left) kms_cursor_crc (cursor-rapid-movement-64x21)
[164.932760] Starting subtest: cursor-rapid-movement-64x21
[164.981276] Subtest cursor-rapid-movement-64x21: SKIP (0.044s)
[165.235153] [014/131] (854s left) gem_exec_reloc (basic-scanout)
[165.304627] Subtest basic-scanout: SKIP (0.000s)
[165.390212] [015/131] (854s left) kms_dsc (dsc-with-bpc)
[165.479623] Starting subtest: dsc-with-bpc
[165.509467] Subtest dsc-with-bpc: SKIP (0.001s)
[165.572919] [016/131] (854s left) kms_chamelium_color (ctm-green-to-red)
[165.661065] Subtest ctm-green-to-red: SKIP (0.000s)
[165.701629] [017/131] (854s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-blt)
[165.791072] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-blt
[169.941086] Subtest fbc-1p-offscreen-pri-indfb-draw-blt: SUCCESS (4.153s)
[171.141967] [018/131] (848s left) gem_exec_reloc (basic-wc-cpu-active)
[171.221040] Subtest basic-wc-cpu-active: SKIP (0.000s)
[171.302290] [019/131] (848s left) kms_big_fb (x-tiled-8bpp-rotate-180)
[171.408626] Starting subtest: x-tiled-8bpp-rotate-180
[172.576802] Subtest x-tiled-8bpp-rotate-180: SUCCESS (1.167s)
[172.732150] [020/131] (847s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-shrfb-msflip-blt)
[172.829442] Starting subtest: fbcpsr-2p-scndscrn-shrfb-msflip-blt
[172.832919] Subtest fbcpsr-2p-scndscrn-shrfb-msflip-blt: SKIP (0.000s)
[172.933688] [021/131] (847s left) gem_exec_fence (syncobj-channel)
[173.350836] Starting subtest: syncobj-channel
[174.371237] Subtest syncobj-channel: SUCCESS (1.015s)
[175.068758] [022/131] (845s left) gem_busy (extended)
[175.269030] Starting subtest: extended
[175.271849] Starting dynamic subtest: rcs0
[175.381462] Dynamic subtest rcs0: SUCCESS (0.113s)
[175.392605] Starting dynamic subtest: bcs0
[175.425858] Dynamic subtest bcs0: SUCCESS (0.043s)
[175.436434] Starting dynamic subtest: vcs0
[176.917194] Dynamic subtest vcs0: SUCCESS (1.488s)
[176.927743] Starting dynamic subtest: vcs1
[178.902114] Dynamic subtest vcs1: SUCCESS (1.982s)
[178.913013] Starting dynamic subtest: vecs0
[180.885285] Dynamic subtest vecs0: SUCCESS (1.981s)
[180.895708] Starting dynamic subtest: ccs0
[180.929986] Dynamic subtest ccs0: SUCCESS (0.044s)
[180.932370] Subtest extended: SUCCESS (5.663s)
[181.216925] [023/131] (839s left) gem_exec_flush (basic-uc-rw-default)
[181.271371] Starting subtest: basic-uc-rw-default
[186.737288] Subtest basic-uc-rw-default: SUCCESS (5.467s)
[186.946593] [024/131] (833s left) kms_chamelium_hpd (dp-hpd-storm-disable)
[187.338885] Subtest dp-hpd-storm-disable: SKIP (0.000s)
[188.110019] [025/131] (832s left) kms_lease (setcrtc-implicit-plane)
[188.212668] Starting subtest: setcrtc-implicit-plane
[188.214677] Starting dynamic subtest: pipe-A-eDP-1
[188.673680] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.462s)
[188.683082] Starting dynamic subtest: pipe-B-eDP-1
[189.777923] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.104s)
[189.785648] Starting dynamic subtest: pipe-C-eDP-1
[190.886777] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.105s)
[190.898061] Starting dynamic subtest: pipe-D-eDP-1
[192.014886] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.127s)
[192.017665] Subtest setcrtc-implicit-plane: SUCCESS (3.803s)
[192.875206] [026/131] (827s left) kms_frontbuffer_tracking (fbc-tiling-y)
[192.981774] Starting subtest: fbc-tiling-y
[192.986235] Subtest fbc-tiling-y: SKIP (0.000s)
[193.101310] [027/131] (827s left) kms_prop_blob (blob-prop-validate)
[193.155832] Starting subtest: blob-prop-validate
[193.157737] Subtest blob-prop-validate: SUCCESS (0.000s)
[193.270529] [028/131] (827s left) kms_flip (flip-vs-dpms-on-nop-interruptible)
[193.358311] Starting subtest: flip-vs-dpms-on-nop-interruptible
[193.360751] Starting dynamic subtest: A-eDP1
[195.246032] Dynamic subtest A-eDP1: SUCCESS (1.887s)
[195.256455] Starting dynamic subtest: B-eDP1
[197.097025] Dynamic subtest B-eDP1: SUCCESS (1.850s)
[197.107496] Starting dynamic subtest: C-eDP1
[198.907643] Dynamic subtest C-eDP1: SUCCESS (1.809s)
[198.916901] Starting dynamic subtest: D-eDP1
[200.739837] Dynamic subtest D-eDP1: SUCCESS (1.832s)
[200.742286] Subtest flip-vs-dpms-on-nop-interruptible: SUCCESS (7.386s)
[201.946398] [029/131] (818s left) kms_psr (psr2-sprite-plane-onoff)
[202.030073] Starting subtest: psr2-sprite-plane-onoff
[202.032398] Starting dynamic subtest: eDP-1
[203.723282] Dynamic subtest eDP-1: SUCCESS (1.692s)
[203.725105] Subtest psr2-sprite-plane-onoff: SUCCESS (1.693s)
[204.605905] [030/131] (815s left) syncobj_wait (multi-wait-signaled)
[204.666679] Starting subtest: multi-wait-signaled
[204.668622] Subtest multi-wait-signaled: SUCCESS (0.000s)
[204.791530] [031/131] (815s left) gem_ctx_shared (q-promotion)
[204.855700] Starting subtest: Q-promotion
[204.857952] Starting dynamic subtest: rcs0
[204.958892] Dynamic subtest rcs0: SUCCESS (0.102s)
[204.974882] Starting dynamic subtest: vcs0
[205.038596] Dynamic subtest vcs0: SUCCESS (0.079s)
[205.052118] Starting dynamic subtest: vcs1
[205.117688] Dynamic subtest vcs1: SUCCESS (0.078s)
[205.132933] Starting dynamic subtest: vecs0
[205.193261] Dynamic subtest vecs0: SUCCESS (0.075s)
[205.208161] Starting dynamic subtest: ccs0
[205.269285] Dynamic subtest ccs0: SUCCESS (0.075s)
[205.272025] Subtest Q-promotion: SUCCESS (0.413s)
[207.052815] [032/131] (813s left) tools_test (tools_test)
[207.102911] Starting subtest: tools_test
[207.155043] Subtest tools_test: SUCCESS (0.068s)
[207.246204] [033/131] (813s left) gem_softpin (evict-active-interruptible)
[207.309711] Starting subtest: evict-active-interruptible
[207.320567] Subtest evict-active-interruptible: SUCCESS (0.011s)
[207.441947] [034/131] (813s left) sw_sync (alloc_timeline)
[207.472586] Starting subtest: alloc_timeline
[207.474491] Subtest alloc_timeline: SUCCESS (0.000s)
[207.560998] [035/131] (813s left) gem_eio (in-flight-1us)
[207.794343] Starting subtest: in-flight-1us
[216.895337] Subtest in-flight-1us: SUCCESS (9.099s)
[217.106396] [036/131] (803s left) kms_big_fb (4-tiled-64bpp-rotate-270)
[217.213198] Starting subtest: 4-tiled-64bpp-rotate-270
[217.238498] Subtest 4-tiled-64bpp-rotate-270: SKIP (0.025s)
[217.397209] [037/131] (803s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-pwrite)
[217.503390] Starting subtest: psr-2p-primscrn-spr-indfb-draw-pwrite
[217.507251] Subtest psr-2p-primscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[217.621379] [038/131] (803s left) gem_mmap_offset (partial-mmap)
[217.676642] Starting subtest: partial-mmap
[217.678291] Starting dynamic subtest: smem0
[217.680276] Dynamic subtest smem0: SUCCESS (0.003s)
[217.682098] Subtest partial-mmap: SUCCESS (0.004s)
[217.813646] [039/131] (803s left) i915_selftest (perf)
[221.236095] Starting subtest: perf
[221.241893] Starting dynamic subtest: engine_cs
[225.735124] Dynamic subtest engine_cs: SUCCESS (4.497s)
[225.743893] Starting dynamic subtest: request
[233.113686] Dynamic subtest request: SUCCESS (7.377s)
[233.122744] Starting dynamic subtest: migrate
[237.595260] Dynamic subtest migrate: SUCCESS (4.480s)
[237.604778] Starting dynamic subtest: region
[243.486078] Dynamic subtest region: SUCCESS (5.889s)
[243.489066] Subtest perf: SUCCESS (22.250s)
[243.517185] [FACT i915_selftest (perf)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[243.517869] [FACT i915_selftest (perf)] deleted: kernel.kmod_is_loaded.i915: true
[243.521030] [040/131] (777s left) kms_content_protection (dp-mst-type-1)
[245.126636] Starting subtest: dp-mst-type-1
[245.131351] Subtest dp-mst-type-1: SKIP (0.000s)
[245.236718] [FACT kms_content_protection (dp-mst-type-1)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[245.237934] [FACT kms_content_protection (dp-mst-type-1)] new: kernel.kmod_is_loaded.i915: true
[245.241583] [041/131] (775s left) gem_exec_alignment (single)
[245.309992] Starting subtest: single
[245.315309] Subtest single: SUCCESS (0.004s)
[245.488919] [042/131] (775s left) api_intel_bb (object-noreloc-keep-cache-simple)
[245.555389] Starting subtest: object-noreloc-keep-cache-simple
[245.558326] Subtest object-noreloc-keep-cache-simple: SUCCESS (0.005s)
[245.701181] [043/131] (775s left) syncobj_timeline (etime-multi-wait-all-for-submit-unsubmitted)
[245.762559] Starting subtest: etime-multi-wait-all-for-submit-unsubmitted
[245.866408] Subtest etime-multi-wait-all-for-submit-unsubmitted: SUCCESS (0.103s)
[245.961721] [044/131] (775s left) prime_vgem (basic-read)
[246.058361] Starting subtest: basic-read
[246.062963] Subtest basic-read: SKIP (0.005s)
[246.188415] [045/131] (775s left) perf_pmu (most-busy-idle-check-all)
[246.222660] Starting subtest: most-busy-idle-check-all
[246.224952] Starting dynamic subtest: rcs0
[247.899485] Dynamic subtest rcs0: SUCCESS (1.676s)
[247.909737] Starting dynamic subtest: bcs0
[249.879201] Dynamic subtest bcs0: SUCCESS (1.977s)
[249.890304] Starting dynamic subtest: vcs0
[251.927441] Dynamic subtest vcs0: SUCCESS (2.045s)
[251.938188] Starting dynamic subtest: vcs1
[253.910393] Dynamic subtest vcs1: SUCCESS (1.980s)
[253.920039] Starting dynamic subtest: vecs0
[255.893504] Dynamic subtest vecs0: SUCCESS (1.980s)
[255.903277] Starting dynamic subtest: ccs0
[257.878115] Dynamic subtest ccs0: SUCCESS (1.982s)
[257.880958] Subtest most-busy-idle-check-all: SUCCESS (11.656s)
[257.996433] [046/131] (763s left) kms_flip (flip-vs-blocking-wf-vblank)
[258.105438] Starting subtest: flip-vs-blocking-wf-vblank
[258.107305] Starting dynamic subtest: A-eDP1
[267.027909] Dynamic subtest A-eDP1: SUCCESS (8.924s)
[267.037711] Starting dynamic subtest: B-eDP1
[275.961566] Dynamic subtest B-eDP1: SUCCESS (8.932s)
[275.970799] Starting dynamic subtest: C-eDP1
[284.879507] Dynamic subtest C-eDP1: SUCCESS (8.916s)
[284.888326] Starting dynamic subtest: D-eDP1
[293.817605] Dynamic subtest D-eDP1: SUCCESS (8.935s)
[293.819818] Subtest flip-vs-blocking-wf-vblank: SUCCESS (35.715s)
[295.068430] [047/131] (726s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-blt)
[295.165110] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-blt
[295.169081] Subtest psr-2p-scndscrn-cur-indfb-draw-blt: SKIP (0.000s)
[295.308300] [048/131] (726s left) syncobj_timeline (multi-wait-all-for-submit-available-submitted)
[295.377409] Starting subtest: multi-wait-all-for-submit-available-submitted
[295.379669] Subtest multi-wait-all-for-submit-available-submitted: SUCCESS (0.000s)
[295.503253] [049/131] (725s left) api_intel_allocator (execbuf-with-allocator)
[295.568564] Starting subtest: execbuf-with-allocator
[295.573396] Subtest execbuf-with-allocator: SUCCESS (0.004s)
[295.742356] [050/131] (725s left) gem_lmem_swapping (parallel-random)
[295.790066] Subtest parallel-random: SKIP (0.000s)
[295.843862] [051/131] (725s left) kms_frontbuffer_tracking (fbcpsr-1p-rte)
[295.929249] Starting subtest: fbcpsr-1p-rte
[302.939879] Subtest fbcpsr-1p-rte: SUCCESS (7.014s)
[303.131163] [052/131] (718s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-0-hflip)
[303.244860] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-0-hflip
[303.249244] Subtest y-tiled-max-hw-stride-32bpp-rotate-0-hflip: SKIP (0.000s)
[303.364672] [053/131] (718s left) gem_exec_schedule (preempt-engines)
[303.446969] Starting subtest: preempt-engines
[303.449667] Starting dynamic subtest: rcs0
[305.673192] Dynamic subtest rcs0: SUCCESS (2.226s)
[305.684617] Starting dynamic subtest: bcs0
[307.870330] Dynamic subtest bcs0: SUCCESS (2.195s)
[307.881612] Starting dynamic subtest: vcs0
[310.109540] Dynamic subtest vcs0: SUCCESS (2.238s)
[310.123724] Starting dynamic subtest: vcs1
[312.371081] Dynamic subtest vcs1: SUCCESS (2.260s)
[312.382554] Starting dynamic subtest: vecs0
[314.613856] Dynamic subtest vecs0: SUCCESS (2.240s)
[314.623569] Starting dynamic subtest: ccs0
[316.880851] Dynamic subtest ccs0: SUCCESS (2.266s)
[316.883255] Subtest preempt-engines: SUCCESS (13.435s)
[317.226863] [054/131] (704s left) gen9_exec_parse (secure-batches)
[317.289790] Subtest secure-batches: SKIP (0.000s)
[317.374294] [055/131] (704s left) kms_getfb (getfb-addfb-different-handles)
[317.469073] Starting subtest: getfb-addfb-different-handles
[317.471321] Subtest getfb-addfb-different-handles: SUCCESS (0.000s)
[317.603242] [056/131] (704s left) kms_pm_rpm (modeset-lpsp)
[319.140095] Starting subtest: modeset-lpsp
[320.612158] Subtest modeset-lpsp: SUCCESS (1.475s)
[320.756953] [057/131] (700s left) kms_atomic_interruptible (universal-setplane-cursor)
[320.848193] Starting subtest: universal-setplane-cursor
[320.850472] Starting dynamic subtest: pipe-A-eDP-1
[328.286804] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.439s)
[328.289063] Subtest universal-setplane-cursor: SUCCESS (7.440s)
[329.150962] [058/131] (692s left) i915_query (query-topology-kernel-writes)
[329.226130] Starting subtest: query-topology-kernel-writes
[329.228525] Subtest query-topology-kernel-writes: SUCCESS (0.000s)
[329.358767] [059/131] (692s left) gem_tiled_wb
[329.500380] [060/131] (692s left) kms_big_fb (yf-tiled-8bpp-rotate-180)
[329.618420] Starting subtest: yf-tiled-8bpp-rotate-180
[329.622700] Subtest yf-tiled-8bpp-rotate-180: SKIP (0.000s)
[329.749877] [061/131] (692s left) kms_plane_scaling (planes-downscale-factor-0-5)
[329.839360] Starting subtest: planes-downscale-factor-0-5
[329.841741] Starting dynamic subtest: pipe-A
[329.860180] Dynamic subtest pipe-A: SKIP (0.016s)
[329.868488] Starting dynamic subtest: pipe-B
[329.888671] Dynamic subtest pipe-B: SKIP (0.028s)
[329.896458] Starting dynamic subtest: pipe-C
[329.916867] Dynamic subtest pipe-C: SKIP (0.028s)
[329.924548] Starting dynamic subtest: pipe-D
[329.944438] Dynamic subtest pipe-D: SKIP (0.028s)
[329.948326] Subtest planes-downscale-factor-0-5: SKIP (0.103s)
[330.071659] [062/131] (691s left) gem_exec_schedule (preempt-queue-contexts-chain)
[330.157512] Subtest preempt-queue-contexts-chain: SKIP (0.000s)
[330.468320] [063/131] (691s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-mmap-wc)
[330.570439] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-mmap-wc
[334.164060] Subtest fbc-1p-primscrn-spr-indfb-draw-mmap-wc: SUCCESS (3.598s)
[335.372150] [064/131] (686s left) kms_invalid_mode (bad-vtotal)
[335.485129] Starting subtest: bad-vtotal
[335.487309] Starting dynamic subtest: pipe-A-eDP-1
[335.774527] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.291s)
[335.782866] Starting dynamic subtest: pipe-B-eDP-1
[335.785057] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[335.792427] Starting dynamic subtest: pipe-C-eDP-1
[335.794642] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[335.802079] Starting dynamic subtest: pipe-D-eDP-1
[335.803922] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[335.805771] Subtest bad-vtotal: SUCCESS (0.297s)
[336.600799] [065/131] (685s left) kms_ccs (bad-pixel-format-4-tiled-mtl-rc-ccs)
[336.702099] Starting subtest: bad-pixel-format-4-tiled-mtl-rc-ccs
[336.704341] Starting dynamic subtest: pipe-A-eDP-1
[336.725244] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s)
[336.735214] Starting dynamic subtest: pipe-B-eDP-1
[336.754348] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[336.761633] Starting dynamic subtest: pipe-C-eDP-1
[336.781858] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[336.788994] Starting dynamic subtest: pipe-D-eDP-1
[336.807242] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[336.809095] Subtest bad-pixel-format-4-tiled-mtl-rc-ccs: SUCCESS (0.005s)
[338.950254] [066/131] (683s left) gem_exec_balancer (invalid-balancer)
[339.015935] Starting subtest: invalid-balancer
[339.861284] Subtest invalid-balancer: SUCCESS (0.846s)
[340.192200] [067/131] (681s left) kms_plane_scaling (planes-upscale-20x20)
[340.299353] Starting subtest: planes-upscale-20x20
[340.301655] Starting dynamic subtest: pipe-A
[340.359270] Dynamic subtest pipe-A: SUCCESS (0.062s)
[340.369380] Starting dynamic subtest: pipe-B
[341.457582] Dynamic subtest pipe-B: SUCCESS (1.098s)
[341.466743] Starting dynamic subtest: pipe-C
[342.566306] Dynamic subtest pipe-C: SUCCESS (1.106s)
[342.574828] Starting dynamic subtest: pipe-D
[343.704811] Dynamic subtest pipe-D: SUCCESS (1.137s)
[343.707507] Subtest planes-upscale-20x20: SUCCESS (3.409s)
[344.882184] [068/131] (677s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-mmap-cpu)
[344.991864] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-mmap-cpu
[344.996294] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[345.126075] [069/131] (677s left) gem_mmap_wc (read-write)
[345.195229] Subtest read-write: SKIP (0.000s)
[345.276454] [070/131] (676s left) gem_pxp (create-regular-context-1)
[345.405054] Starting subtest: create-regular-context-1
[345.407918] Subtest create-regular-context-1: SUCCESS (0.002s)
[345.551192] [071/131] (676s left) kms_addfb_basic (invalid-get-prop)
[345.611238] Starting subtest: invalid-get-prop
[345.613492] Subtest invalid-get-prop: SUCCESS (0.000s)
[345.755698] [072/131] (676s left) kms_frontbuffer_tracking (fbc-1p-primscrn-shrfb-msflip-blt)
[345.858727] Starting subtest: fbc-1p-primscrn-shrfb-msflip-blt
[350.360344] Subtest fbc-1p-primscrn-shrfb-msflip-blt: SUCCESS (4.503s)
[351.573571] [073/131] (670s left) syncobj_timeline (wait-all-complex)
[351.634993] Starting subtest: wait-all-complex
[351.848042] Subtest wait-all-complex: SUCCESS (0.213s)
[351.947700] [074/131] (670s left) gem_softpin (zero)
[351.999848] Starting subtest: zero
[352.004331] Subtest zero: SUCCESS (0.005s)
[352.183418] [075/131] (670s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-blt)
[352.293693] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-blt
[352.298018] Subtest fbc-2p-primscrn-spr-indfb-draw-blt: SKIP (0.000s)
[352.430865] [076/131] (670s left) kms_ccs (crc-primary-basic-y-tiled-gen12-rc-ccs-cc)
[352.534169] Starting subtest: crc-primary-basic-y-tiled-gen12-rc-ccs-cc
[352.536461] Starting dynamic subtest: pipe-A-eDP-1
[352.559232] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[352.569559] Starting dynamic subtest: pipe-B-eDP-1
[352.591176] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[352.599483] Starting dynamic subtest: pipe-C-eDP-1
[352.621568] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[352.630263] Starting dynamic subtest: pipe-D-eDP-1
[352.651414] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[352.655730] Subtest crc-primary-basic-y-tiled-gen12-rc-ccs-cc: SKIP (0.007s)
[354.828711] [077/131] (667s left) kms_cursor_legacy (nonblocking-modeset-vs-cursor-atomic)
[354.951973] Starting subtest: nonblocking-modeset-vs-cursor-atomic
[356.375641] Subtest nonblocking-modeset-vs-cursor-atomic: SUCCESS (1.424s)
[357.201738] [078/131] (665s left) kms_vrr (negative-basic)
[357.293253] Starting subtest: negative-basic
[357.300052] Starting dynamic subtest: pipe-A-eDP-1
[362.712778] Dynamic subtest pipe-A-eDP-1: SUCCESS (5.412s)
[363.000764] Subtest negative-basic: SUCCESS (5.709s)
[363.826564] [079/131] (658s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-downscaling)
[363.924717] Starting subtest: flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-downscaling
[363.926964] Starting dynamic subtest: pipe-A-default-mode
[364.214439] Dynamic subtest pipe-A-default-mode: SKIP (0.286s)
[364.219178] Subtest flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-downscaling: SKIP (0.288s)
[365.059821] [080/131] (657s left) syncobj_timeline (single-wait-all-available-signaled)
[365.117884] Starting subtest: single-wait-all-available-signaled
[365.119945] Subtest single-wait-all-available-signaled: SUCCESS (0.000s)
[365.250666] [081/131] (657s left) gem_reg_read (bad-register)
[365.305436] Starting subtest: bad-register
[365.307595] Subtest bad-register: SUCCESS (0.000s)
[365.426561] [082/131] (657s left) gem_exec_fence (basic-wait-all)
[365.493075] Starting subtest: basic-wait-all
[365.595254] Subtest basic-wait-all: SUCCESS (0.104s)
[368.028925] [083/131] (654s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-mmap-gtt)
[368.138234] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-mmap-gtt
[368.142606] Subtest fbc-2p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[368.259231] [084/131] (654s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-mmap-gtt)
[368.366958] Starting subtest: psr-1p-primscrn-spr-indfb-draw-mmap-gtt
[368.371458] Subtest psr-1p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[368.490395] [085/131] (654s left) gem_ctx_persistence (engines-queued)
[368.550520] Starting subtest: engines-queued
[368.552875] Starting dynamic subtest: rcs0
[368.669688] Dynamic subtest rcs0: SUCCESS (0.119s)
[368.681091] Starting dynamic subtest: bcs0
[368.745757] Dynamic subtest bcs0: SUCCESS (0.074s)
[368.756760] Starting dynamic subtest: vcs0
[369.845601] Dynamic subtest vcs0: SUCCESS (1.096s)
[369.857148] Starting dynamic subtest: vcs1
[371.891034] Dynamic subtest vcs1: SUCCESS (2.043s)
[371.901911] Starting dynamic subtest: vecs0
[373.876602] Dynamic subtest vecs0: SUCCESS (1.983s)
[373.887547] Starting dynamic subtest: ccs0
[374.045539] Dynamic subtest ccs0: SUCCESS (0.168s)
[374.047745] Subtest engines-queued: SUCCESS (5.496s)
[374.227829] [086/131] (648s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-render)
[374.339322] Starting subtest: fbcpsr-rgb565-draw-render
[381.346760] Subtest fbcpsr-rgb565-draw-render: SUCCESS (7.009s)
[381.506586] [087/131] (641s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip)
[381.603291] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip
[381.607283] Subtest y-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip: SKIP (0.000s)
[381.722194] [088/131] (641s left) gem_create (create-ext-placement-each)
[381.890968] Starting subtest: create-ext-placement-each
[381.893469] Subtest create-ext-placement-each: SUCCESS (0.000s)
[382.004838] [089/131] (641s left) kms_psr2_su (page_flip-p010)
[382.071621] Subtest page_flip-P010: SKIP (0.000s)
[382.141364] [090/131] (640s left) kms_plane_multiple (tiling-x)
[382.239286] Starting subtest: tiling-x
[382.241938] Starting dynamic subtest: pipe-A-eDP-1
[385.969674] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.731s)
[385.980389] Starting dynamic subtest: pipe-B-eDP-1
[390.309995] Dynamic subtest pipe-B-eDP-1: SUCCESS (4.339s)
[390.318764] Starting dynamic subtest: pipe-C-eDP-1
[394.632917] Dynamic subtest pipe-C-eDP-1: SUCCESS (4.322s)
[394.643221] Starting dynamic subtest: pipe-D-eDP-1
[398.988080] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.352s)
[398.990222] Subtest tiling-x: SUCCESS (16.748s)
[399.825764] [091/131] (623s left) kms_frontbuffer_tracking (fbc-tiling-4)
[399.944371] Starting subtest: fbc-tiling-4
[404.253113] Subtest fbc-tiling-4: SUCCESS (4.309s)
[405.433487] [092/131] (617s left) kms_ccs (crc-primary-rotation-180-4-tiled-mtl-mc-ccs)
[405.532047] Starting subtest: crc-primary-rotation-180-4-tiled-mtl-mc-ccs
[405.534251] Starting dynamic subtest: pipe-A-eDP-1
[407.542234] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.010s)
[407.550302] Starting dynamic subtest: pipe-B-eDP-1
[409.836915] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.295s)
[409.844840] Starting dynamic subtest: pipe-C-eDP-1
[411.862994] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.022s)
[411.871170] Starting dynamic subtest: pipe-D-eDP-1
[413.915276] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.051s)
[413.917332] Subtest crc-primary-rotation-180-4-tiled-mtl-mc-ccs: SUCCESS (8.384s)
[415.168571] [093/131] (608s left) prime_mmap (test_aperture_limit)
[415.238536] Starting subtest: test_aperture_limit
[415.240652] Starting dynamic subtest: test_aperture_limit-smem
[415.248326] Dynamic subtest test_aperture_limit-smem: SKIP (0.008s)
[415.252737] Subtest test_aperture_limit: SKIP (0.008s)
[415.345194] [094/131] (607s left) kms_addfb_basic (addfb25-yf-tiled-legacy)
[415.447945] Starting subtest: addfb25-yf-tiled-legacy
[415.450094] Subtest addfb25-yf-tiled-legacy: SUCCESS (0.000s)
[415.573805] [095/131] (607s left) perf (gen12-group-concurrent-oa-buffer-read)
[415.729963] Starting subtest: gen12-group-concurrent-oa-buffer-read
[425.766446] Subtest gen12-group-concurrent-oa-buffer-read: SUCCESS (10.036s)
[425.813794] [096/131] (597s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-render)
[425.906313] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-render
[425.910261] Subtest psr-2p-scndscrn-spr-indfb-draw-render: SKIP (0.000s)
[426.040927] [097/131] (597s left) kms_psr (pr-no-drrs)
[426.131114] Starting subtest: pr-no-drrs
[426.135064] Subtest pr-no-drrs: SKIP (0.000s)
[426.225555] [098/131] (597s left) kms_cursor_crc (cursor-offscreen-128x128)
[426.434994] Starting subtest: cursor-offscreen-128x128
[426.437380] Starting dynamic subtest: pipe-A-eDP-1
[428.365838] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.929s)
[428.391910] Starting dynamic subtest: pipe-D-eDP-1
[430.935882] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.551s)
[430.938503] Subtest cursor-offscreen-128x128: SUCCESS (4.503s)
[431.818093] [099/131] (591s left) kms_rotation_crc (primary-x-tiled-reflect-x-180)
[431.922597] Starting subtest: primary-x-tiled-reflect-x-180
[438.952000] Subtest primary-x-tiled-reflect-x-180: SUCCESS (7.030s)
[440.184760] [100/131] (583s left) syncobj_timeline (etime-multi-wait-for-submit-submitted)
[440.243699] Starting subtest: etime-multi-wait-for-submit-submitted
[440.344819] Subtest etime-multi-wait-for-submit-submitted: SUCCESS (0.102s)
[440.444252] [101/131] (583s left) gem_exec_balancer (parallel-out-fence)
[440.695228] Starting subtest: parallel-out-fence
[441.808885] Subtest parallel-out-fence: SUCCESS (1.114s)
[441.954704] [102/131] (581s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-pwrite)
[442.062466] Starting subtest: fbc-rgb101010-draw-pwrite
[447.411372] Subtest fbc-rgb101010-draw-pwrite: SUCCESS (5.351s)
[448.580764] [103/131] (575s left) gem_render_copy (yf-tiled-mc-ccs-to-vebox-yf-tiled)
[448.643896] Starting subtest: yf-tiled-mc-ccs-to-vebox-yf-tiled
[448.648584] Subtest yf-tiled-mc-ccs-to-vebox-yf-tiled: SKIP (0.000s)
[448.851927] [104/131] (574s left) i915_pm_rpm (gem-idle)
[451.070933] Starting subtest: gem-idle
[457.283175] Subtest gem-idle: SUCCESS (6.213s)
[457.633970] [105/131] (566s left) kms_addfb_basic (framebuffer-vs-set-tiling)
[458.809146] Starting subtest: framebuffer-vs-set-tiling
[458.813710] Subtest framebuffer-vs-set-tiling: SKIP (0.000s)
[458.982114] [106/131] (564s left) kms_chamelium_edid (dp-edid-stress-resolution-4k)
[459.376884] Subtest dp-edid-stress-resolution-4k: SKIP (0.000s)
[460.257318] [107/131] (563s left) gem_pxp (verify-pxp-stale-ctx-execution)
[460.377987] Starting subtest: verify-pxp-stale-ctx-execution
[461.440982] Subtest verify-pxp-stale-ctx-execution: SUCCESS (1.062s)
[461.617952] [108/131] (562s left) gem_exec_whisper (basic-normal)
[461.687518] Starting subtest: basic-normal
[466.203063] Subtest basic-normal: SUCCESS (4.516s)
[466.414359] [109/131] (557s left) kms_ccs (missing-ccs-buffer-4-tiled-mtl-mc-ccs)
[466.526634] Starting subtest: missing-ccs-buffer-4-tiled-mtl-mc-ccs
[466.528608] Starting dynamic subtest: pipe-A-eDP-1
[466.549443] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.020s)
[466.559985] Starting dynamic subtest: pipe-B-eDP-1
[466.579789] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.019s)
[466.590631] Starting dynamic subtest: pipe-C-eDP-1
[466.610394] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.020s)
[466.618950] Starting dynamic subtest: pipe-D-eDP-1
[466.638359] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.019s)
[466.640270] Subtest missing-ccs-buffer-4-tiled-mtl-mc-ccs: SUCCESS (0.082s)
[468.830377] [110/131] (555s left) kms_flip (modeset-vs-vblank-race-interruptible)
[468.929159] Starting subtest: modeset-vs-vblank-race-interruptible
[468.931479] Starting dynamic subtest: A-eDP1
[473.617995] Dynamic subtest A-eDP1: SUCCESS (4.687s)
[473.629221] Starting dynamic subtest: B-eDP1
[478.249726] Dynamic subtest B-eDP1: SUCCESS (4.629s)
[478.264216] Starting dynamic subtest: C-eDP1
[482.782038] Dynamic subtest C-eDP1: SUCCESS (4.531s)
[482.794599] Starting dynamic subtest: D-eDP1
[487.308312] Dynamic subtest D-eDP1: SUCCESS (4.523s)
[487.313541] Subtest modeset-vs-vblank-race-interruptible: SUCCESS (18.383s)
[488.498858] [111/131] (535s left) kms_psr2_sf (psr2-cursor-plane-move-continuous-exceed-fully-sf)
[493.558483] Starting subtest: psr2-cursor-plane-move-continuous-exceed-fully-sf
[493.560815] Starting dynamic subtest: pipe-A-eDP-1
[505.276101] Dynamic subtest pipe-A-eDP-1: SUCCESS (11.717s)
[505.285909] Starting dynamic subtest: pipe-B-eDP-1
[517.015623] Dynamic subtest pipe-B-eDP-1: SUCCESS (11.734s)
[517.017939] Subtest psr2-cursor-plane-move-continuous-exceed-fully-sf: SUCCESS (23.455s)
[517.900353] [112/131] (506s left) kms_frontbuffer_tracking (fbcpsr-shrfb-scaledprimary)
[518.020468] Starting subtest: fbcpsr-shrfb-scaledprimary
[523.748492] Subtest fbcpsr-shrfb-scaledprimary: SUCCESS (5.731s)
[523.930952] [113/131] (500s left) kms_psr (fbc-psr-sprite-plane-onoff)
[524.016791] Starting subtest: fbc-psr-sprite-plane-onoff
[524.019070] Starting dynamic subtest: eDP-1
[524.023109] Dynamic subtest eDP-1: SKIP (0.000s)
[524.027320] Subtest fbc-psr-sprite-plane-onoff: SKIP (0.001s)
[524.115546] [114/131] (499s left) gem_partial_pwrite_pread (writes-after-reads)
[524.177464] Subtest writes-after-reads: SKIP (0.000s)
[524.273054] [115/131] (499s left) kms_selftest (drm_format)
[524.316350] Starting subtest: drm_format
[524.350475] Starting dynamic subtest: drm_test_format_block_width_invalid
[524.492149] Dynamic subtest drm_test_format_block_width_invalid: SUCCESS (0.141s)
[524.500114] Starting dynamic subtest: drm_test_format_block_width_one_plane
[524.589048] Dynamic subtest drm_test_format_block_width_one_plane: SUCCESS (0.096s)
[524.598943] Starting dynamic subtest: drm_test_format_block_width_two_plane
[524.722737] Dynamic subtest drm_test_format_block_width_two_plane: SUCCESS (0.132s)
[524.731212] Starting dynamic subtest: drm_test_format_block_width_three_plane
[524.868205] Dynamic subtest drm_test_format_block_width_three_plane: SUCCESS (0.144s)
[524.877607] Starting dynamic subtest: drm_test_format_block_width_tiled
[524.995335] Dynamic subtest drm_test_format_block_width_tiled: SUCCESS (0.127s)
[525.002898] Starting dynamic subtest: drm_test_format_block_height_invalid
[525.142153] Dynamic subtest drm_test_format_block_height_invalid: SUCCESS (0.146s)
[525.150338] Starting dynamic subtest: drm_test_format_block_height_one_plane
[525.271957] Dynamic subtest drm_test_format_block_height_one_plane: SUCCESS (0.128s)
[525.280060] Starting dynamic subtest: drm_test_format_block_height_two_plane
[525.423277] Dynamic subtest drm_test_format_block_height_two_plane: SUCCESS (0.152s)
[525.430805] Starting dynamic subtest: drm_test_format_block_height_three_plane
[525.561623] Dynamic subtest drm_test_format_block_height_three_plane: SUCCESS (0.135s)
[525.571475] Starting dynamic subtest: drm_test_format_block_height_tiled
[525.702619] Dynamic subtest drm_test_format_block_height_tiled: SUCCESS (0.142s)
[525.711641] Starting dynamic subtest: drm_test_format_min_pitch_invalid
[525.836573] Dynamic subtest drm_test_format_min_pitch_invalid: SUCCESS (0.133s)
[525.844506] Starting dynamic subtest: drm_test_format_min_pitch_one_plane_8bpp
[525.974373] Dynamic subtest drm_test_format_min_pitch_one_plane_8bpp: SUCCESS (0.137s)
[525.982237] Starting dynamic subtest: drm_test_format_min_pitch_one_plane_16bpp
[526.071373] Dynamic subtest drm_test_format_min_pitch_one_plane_16bpp: SUCCESS (0.097s)
[526.079198] Starting dynamic subtest: drm_test_format_min_pitch_one_plane_24bpp
[526.219591] Dynamic subtest drm_test_format_min_pitch_one_plane_24bpp: SUCCESS (0.146s)
[526.227510] Starting dynamic subtest: drm_test_format_min_pitch_one_plane_32bpp
[526.358817] Dynamic subtest drm_test_format_min_pitch_one_plane_32bpp: SUCCESS (0.138s)
[526.367294] Starting dynamic subtest: drm_test_format_min_pitch_two_plane
[526.487474] Dynamic subtest drm_test_format_min_pitch_two_plane: SUCCESS (0.128s)
[526.495295] Starting dynamic subtest: drm_test_format_min_pitch_three_plane_8bpp
[526.608731] Dynamic subtest drm_test_format_min_pitch_three_plane_8bpp: SUCCESS (0.120s)
[526.616463] Starting dynamic subtest: drm_test_format_min_pitch_tiled
[526.739098] Dynamic subtest drm_test_format_min_pitch_tiled: SUCCESS (0.131s)
[526.741327] Subtest drm_format: SUCCESS (2.423s)
[526.943022] [116/131] (497s left) kms_vblank (invalid)
[527.056935] Starting subtest: invalid
[527.059143] Starting dynamic subtest: pipe-A-eDP-1
[527.454996] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.398s)
[527.457551] Subtest invalid: SUCCESS (0.400s)
[528.279866] [117/131] (495s left) gem_exec_reloc (basic-cpu-wc-active)
[528.341869] Subtest basic-cpu-wc-active: SKIP (0.000s)
[528.431132] [118/131] (495s left) gem_tiled_partial_pwrite_pread (reads)
[528.504932] Subtest reads: SKIP (0.000s)
[528.576174] [119/131] (495s left) kms_big_fb (linear-8bpp-rotate-180)
[528.676921] Starting subtest: linear-8bpp-rotate-180
[529.890723] Subtest linear-8bpp-rotate-180: SUCCESS (1.213s)
[530.057650] [120/131] (494s left) kms_dp_aux_dev
[530.426401] [121/131] (493s left) syncobj_eventfd (binary-wait-signaled)
[530.486038] Starting subtest: binary-wait-signaled
[530.488285] Subtest binary-wait-signaled: SUCCESS (0.000s)
[530.610493] [122/131] (493s left) gem_softpin (evict-snoop-interruptible)
[530.675616] Starting subtest: evict-snoop-interruptible
[530.680180] Subtest evict-snoop-interruptible: SKIP (0.000s)
[530.841125] [123/131] (493s left) kms_psr2_sf (fbc-psr2-overlay-plane-move-continuous-sf)
[535.825629] Starting subtest: fbc-psr2-overlay-plane-move-continuous-sf
[535.827964] Starting dynamic subtest: pipe-A-eDP-1
[536.636392] Dynamic subtest pipe-A-eDP-1: SKIP (0.808s)
[536.645690] Starting dynamic subtest: pipe-B-eDP-1
[537.765766] Dynamic subtest pipe-B-eDP-1: SKIP (1.127s)
[537.770128] Subtest fbc-psr2-overlay-plane-move-continuous-sf: SKIP (1.940s)
[538.976113] [124/131] (485s left) sysfs_timeslice_duration (invalid)
[539.038628] Starting subtest: invalid
[539.040818] Starting dynamic subtest: vecs0
[539.043088] Dynamic subtest vecs0: SUCCESS (0.000s)
[539.052519] Starting dynamic subtest: ccs0
[539.054374] Dynamic subtest ccs0: SUCCESS (0.000s)
[539.061881] Starting dynamic subtest: vcs0
[539.063688] Dynamic subtest vcs0: SUCCESS (0.000s)
[539.071300] Starting dynamic subtest: bcs0
[539.073169] Dynamic subtest bcs0: SUCCESS (0.000s)
[539.080933] Starting dynamic subtest: rcs0
[539.082788] Dynamic subtest rcs0: SUCCESS (0.000s)
[539.090507] Starting dynamic subtest: vcs1
[539.092728] Dynamic subtest vcs1: SUCCESS (0.000s)
[539.094788] Subtest invalid: SUCCESS (0.006s)
[539.174899] [125/131] (485s left) kms_psr (fbc-psr2-sprite-mmap-cpu)
[539.271910] Starting subtest: fbc-psr2-sprite-mmap-cpu
[539.274294] Starting dynamic subtest: eDP-1
[539.278654] Dynamic subtest eDP-1: SKIP (0.000s)
[539.283112] Subtest fbc-psr2-sprite-mmap-cpu: SKIP (0.001s)
[539.368362] [126/131] (485s left) drm_read (fault-buffer)
[539.516905] Starting subtest: fault-buffer
[539.519644] Subtest fault-buffer: SUCCESS (0.001s)
[539.690109] [127/131] (484s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip)
[539.800532] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip
[540.402327] Subtest x-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip: SUCCESS (0.603s)
[540.609755] [128/131] (484s left) kms_cursor_crc (cursor-sliding-128x128)
[540.853657] Starting subtest: cursor-sliding-128x128
[540.858347] Starting dynamic subtest: pipe-A-eDP-1
[544.155018] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.296s)
[544.181637] Starting dynamic subtest: pipe-D-eDP-1
[548.042820] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.866s)
[548.044730] Subtest cursor-sliding-128x128: SUCCESS (7.186s)
[548.935425] [129/131] (475s left) kms_frontbuffer_tracking (fbc-indfb-scaledprimary)
[549.034036] Starting subtest: fbc-indfb-scaledprimary
[551.986795] Subtest fbc-indfb-scaledprimary: SUCCESS (2.956s)
[553.131448] [130/131] (471s left) kms_atomic (plane-invalid-params-fence)
[553.232865] Starting subtest: plane-invalid-params-fence
[553.235146] Starting dynamic subtest: pipe-A-eDP-1
[553.586507] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.353s)
[553.588648] Subtest plane-invalid-params-fence: SUCCESS (0.354s)
[554.453818] [131/131] (470s left) core_setmaster (master-drop-set-shared-fd)
[554.556852] Starting subtest: master-drop-set-shared-fd
[554.578748] Subtest master-drop-set-shared-fd: SUCCESS (0.022s)
[554.614188] Closing watchdogs
results: parsing output: 0/ for test: gem_mmap_gtt
results: parsing output: 1/ for test: kms_frontbuffer_tracking
results: parsing output: 2/ for test: gem_ppgtt
results: parsing output: 3/ for test: gem_wait
results: parsing output: 4/ for test: kms_lease
results: parsing output: 5/ for test: i915_pm_freq_api
results: parsing output: 6/ for test: kms_cursor_legacy
results: parsing output: 7/ for test: gem_mmap_gtt
results: parsing output: 8/ for test: i915_drm_fdinfo
results: parsing output: 9/ for test: gem_partial_pwrite_pread
results: parsing output: 10/ for test: gem_ctx_exec
results: parsing output: 11/ for test: kms_atomic_transition
results: parsing output: 12/ for test: kms_cursor_crc
results: parsing output: 13/ for test: gem_exec_reloc
results: parsing output: 14/ for test: kms_dsc
results: parsing output: 15/ for test: kms_chamelium_color
results: parsing output: 16/ for test: kms_frontbuffer_tracking
results: parsing output: 17/ for test: gem_exec_reloc
results: parsing output: 18/ for test: kms_big_fb
results: parsing output: 19/ for test: kms_frontbuffer_tracking
results: parsing output: 20/ for test: gem_exec_fence
results: parsing output: 21/ for test: gem_busy
results: parsing output: 22/ for test: gem_exec_flush
results: parsing output: 23/ for test: kms_chamelium_hpd
results: parsing output: 24/ for test: kms_lease
results: parsing output: 25/ for test: kms_frontbuffer_tracking
results: parsing output: 26/ for test: kms_prop_blob
results: parsing output: 27/ for test: kms_flip
results: parsing output: 28/ for test: kms_psr
results: parsing output: 29/ for test: syncobj_wait
results: parsing output: 30/ for test: gem_ctx_shared
results: parsing output: 31/ for test: tools_test
results: parsing output: 32/ for test: gem_softpin
results: parsing output: 33/ for test: sw_sync
results: parsing output: 34/ for test: gem_eio
results: parsing output: 35/ for test: kms_big_fb
results: parsing output: 36/ for test: kms_frontbuffer_tracking
results: parsing output: 37/ for test: gem_mmap_offset
results: parsing output: 38/ for test: i915_selftest
results: parsing output: 39/ for test: kms_content_protection
results: parsing output: 40/ for test: gem_exec_alignment
results: parsing output: 41/ for test: api_intel_bb
results: parsing output: 42/ for test: syncobj_timeline
results: parsing output: 43/ for test: prime_vgem
results: parsing output: 44/ for test: perf_pmu
results: parsing output: 45/ for test: kms_flip
results: parsing output: 46/ for test: kms_frontbuffer_tracking
results: parsing output: 47/ for test: syncobj_timeline
results: parsing output: 48/ for test: api_intel_allocator
results: parsing output: 49/ for test: gem_lmem_swapping
results: parsing output: 50/ for test: kms_frontbuffer_tracking
results: parsing output: 51/ for test: kms_big_fb
results: parsing output: 52/ for test: gem_exec_schedule
results: parsing output: 53/ for test: gen9_exec_parse
results: parsing output: 54/ for test: kms_getfb
results: parsing output: 55/ for test: kms_pm_rpm
results: parsing output: 56/ for test: kms_atomic_interruptible
results: parsing output: 57/ for test: i915_query
results: parsing output: 58/ for test: gem_tiled_wb
results: parsing output: 59/ for test: kms_big_fb
results: parsing output: 60/ for test: kms_plane_scaling
results: parsing output: 61/ for test: gem_exec_schedule
results: parsing output: 62/ for test: kms_frontbuffer_tracking
results: parsing output: 63/ for test: kms_invalid_mode
results: parsing output: 64/ for test: kms_ccs
results: parsing output: 65/ for test: gem_exec_balancer
results: parsing output: 66/ for test: kms_plane_scaling
results: parsing output: 67/ for test: kms_frontbuffer_tracking
results: parsing output: 68/ for test: gem_mmap_wc
results: parsing output: 69/ for test: gem_pxp
results: parsing output: 70/ for test: kms_addfb_basic
results: parsing output: 71/ for test: kms_frontbuffer_tracking
results: parsing output: 72/ for test: syncobj_timeline
results: parsing output: 73/ for test: gem_softpin
results: parsing output: 74/ for test: kms_frontbuffer_tracking
results: parsing output: 75/ for test: kms_ccs
results: parsing output: 76/ for test: kms_cursor_legacy
results: parsing output: 77/ for test: kms_vrr
results: parsing output: 78/ for test: kms_flip_scaled_crc
results: parsing output: 79/ for test: syncobj_timeline
results: parsing output: 80/ for test: gem_reg_read
results: parsing output: 81/ for test: gem_exec_fence
results: parsing output: 82/ for test: kms_frontbuffer_tracking
results: parsing output: 83/ for test: kms_frontbuffer_tracking
results: parsing output: 84/ for test: gem_ctx_persistence
results: parsing output: 85/ for test: kms_frontbuffer_tracking
results: parsing output: 86/ for test: kms_big_fb
results: parsing output: 87/ for test: gem_create
results: parsing output: 88/ for test: kms_psr2_su
results: parsing output: 89/ for test: kms_plane_multiple
results: parsing output: 90/ for test: kms_frontbuffer_tracking
results: parsing output: 91/ for test: kms_ccs
results: parsing output: 92/ for test: prime_mmap
results: parsing output: 93/ for test: kms_addfb_basic
results: parsing output: 94/ for test: perf
results: parsing output: 95/ for test: kms_frontbuffer_tracking
results: parsing output: 96/ for test: kms_psr
results: parsing output: 97/ for test: kms_cursor_crc
results: parsing output: 98/ for test: kms_rotation_crc
results: parsing output: 99/ for test: syncobj_timeline
results: parsing output: 100/ for test: gem_exec_balancer
results: parsing output: 101/ for test: kms_frontbuffer_tracking
results: parsing output: 102/ for test: gem_render_copy
results: parsing output: 103/ for test: i915_pm_rpm
results: parsing output: 104/ for test: kms_addfb_basic
results: parsing output: 105/ for test: kms_chamelium_edid
results: parsing output: 106/ for test: gem_pxp
results: parsing output: 107/ for test: gem_exec_whisper
results: parsing output: 108/ for test: kms_ccs
results: parsing output: 109/ for test: kms_flip
results: parsing output: 110/ for test: kms_psr2_sf
results: parsing output: 111/ for test: kms_frontbuffer_tracking
results: parsing output: 112/ for test: kms_psr
results: parsing output: 113/ for test: gem_partial_pwrite_pread
results: parsing output: 114/ for test: kms_selftest
results: parsing output: 115/ for test: kms_vblank
results: parsing output: 116/ for test: gem_exec_reloc
results: parsing output: 117/ for test: gem_tiled_partial_pwrite_pread
results: parsing output: 118/ for test: kms_big_fb
results: parsing output: 119/ for test: kms_dp_aux_dev
results: parsing output: 120/ for test: syncobj_eventfd
results: parsing output: 121/ for test: gem_softpin
results: parsing output: 122/ for test: kms_psr2_sf
results: parsing output: 123/ for test: sysfs_timeslice_duration
results: parsing output: 124/ for test: kms_psr
results: parsing output: 125/ for test: drm_read
results: parsing output: 126/ for test: kms_big_fb
results: parsing output: 127/ for test: kms_cursor_crc
results: parsing output: 128/ for test: kms_frontbuffer_tracking
results: parsing output: 129/ for test: kms_atomic
results: parsing output: 130/ for test: core_setmaster
Done.