[60.906204] Initializing watchdogs
[60.906257]   /dev/watchdog0
[60.923693] [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]
[60.928252] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[60.930547] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[60.933983] [001/133] (960s left) syncobj_timeline (invalid-multi-wait-all-unsubmitted-signaled)
[61.017985] Starting subtest: invalid-multi-wait-all-unsubmitted-signaled
[61.020459] Subtest invalid-multi-wait-all-unsubmitted-signaled: SUCCESS (0.001s)
[61.122877] [002/133] (960s left) perf (sysctl-defaults)
[61.181099] Starting subtest: sysctl-defaults
[61.183401] Subtest sysctl-defaults: SUCCESS (0.000s)
[61.272909] [003/133] (960s left) gem_ctx_isolation (preservation-reset)
[61.453755] Starting subtest: preservation-reset
[61.456454] Starting dynamic subtest: rcs0
[61.692481] Dynamic subtest rcs0: SUCCESS (0.240s)
[61.704623] Starting dynamic subtest: bcs0
[61.962805] Dynamic subtest bcs0: SUCCESS (0.268s)
[61.972873] Starting dynamic subtest: vcs0
[62.222304] Dynamic subtest vcs0: SUCCESS (0.258s)
[62.232802] Starting dynamic subtest: vcs1
[64.110786] Dynamic subtest vcs1: SUCCESS (1.878s)
[64.118512] Starting dynamic subtest: vecs0
[66.165180] Dynamic subtest vecs0: SUCCESS (2.044s)
[66.175141] Starting dynamic subtest: ccs0
[68.277224] Dynamic subtest ccs0: SUCCESS (2.107s)
[68.279700] Subtest preservation-reset: SUCCESS (6.800s)
[68.409760] [004/133] (953s left) kms_async_flips (async-flip-with-page-flip-events-linear-atomic)
[68.493712] Starting subtest: async-flip-with-page-flip-events-linear-atomic
[68.868333] Starting dynamic subtest: pipe-A-eDP-1
[71.652354] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.777s)
[72.021748] Starting dynamic subtest: pipe-B-eDP-1
[74.783975] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.764s)
[75.151928] Starting dynamic subtest: pipe-C-eDP-1
[77.920778] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.770s)
[78.285415] Starting dynamic subtest: pipe-D-eDP-1
[81.058294] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.779s)
[81.060978] Subtest async-flip-with-page-flip-events-linear-atomic: SUCCESS (12.547s)
[82.241163] [005/133] (939s left) kms_plane_scaling (plane-scaler-with-clipping-clamping-modifiers)
[82.345396] Starting subtest: plane-scaler-with-clipping-clamping-modifiers
[82.347802] Starting dynamic subtest: pipe-A
[82.683382] Dynamic subtest pipe-A: SUCCESS (0.340s)
[82.692738] Starting dynamic subtest: pipe-B
[84.062539] Dynamic subtest pipe-B: SUCCESS (1.378s)
[84.071292] Starting dynamic subtest: pipe-C
[85.491929] Dynamic subtest pipe-C: SUCCESS (1.428s)
[85.501171] Starting dynamic subtest: pipe-D
[86.954751] Dynamic subtest pipe-D: SUCCESS (1.461s)
[86.958168] Subtest plane-scaler-with-clipping-clamping-modifiers: SUCCESS (4.609s)
[88.091441] [006/133] (933s left) kms_chamelium_hpd (dp-hpd-with-enabled-mode)
[88.486855] Subtest dp-hpd-with-enabled-mode: SKIP (0.000s)
[89.300349] [007/133] (932s left) kms_pm_rpm (modeset-lpsp-stress-no-wait)
[91.065640] Starting subtest: modeset-lpsp-stress-no-wait
[101.118588] Subtest modeset-lpsp-stress-no-wait: SUCCESS (10.051s)
[101.208404] [008/133] (920s left) kms_flip_scaled_crc (flip-64bpp-xtile-to-32bpp-xtile-upscaling)
[101.306740] Starting subtest: flip-64bpp-xtile-to-32bpp-xtile-upscaling
[101.310752] Starting dynamic subtest: pipe-A-default-mode
[104.001293] Dynamic subtest pipe-A-default-mode: SUCCESS (2.692s)
[104.003213] Subtest flip-64bpp-xtile-to-32bpp-xtile-upscaling: SUCCESS (2.693s)
[104.881508] [009/133] (916s left) kms_frontbuffer_tracking (fbc-tiling-linear)
[104.976037] Starting subtest: fbc-tiling-linear
[108.673581] Subtest fbc-tiling-linear: SUCCESS (3.701s)
[109.892854] [010/133] (911s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-blt)
[110.013831] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-blt
[110.018289] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-blt: SKIP (0.000s)
[110.108295] [011/133] (911s left) gem_mmap_gtt (pf-nonblock)
[110.167129] Subtest pf-nonblock: SKIP (0.000s)
[110.231836] [012/133] (911s left) core_setmaster (master-drop-set-root)
[110.294657] Starting subtest: master-drop-set-root
[110.320877] Subtest master-drop-set-root: SUCCESS (0.026s)
[110.365803] [013/133] (911s left) syncobj_basic (bad-fd-to-handle)
[110.423055] Starting subtest: bad-fd-to-handle
[110.425304] Subtest bad-fd-to-handle: SUCCESS (0.000s)
[110.527655] [014/133] (911s left) kms_rotation_crc (multiplane-rotation-cropping-bottom)
[110.622064] Starting subtest: multiplane-rotation-cropping-bottom
[128.216468] Subtest multiplane-rotation-cropping-bottom: SUCCESS (17.593s)
[128.327786] [015/133] (893s left) syncobj_timeline (multi-wait-submitted-signaled)
[128.385462] Starting subtest: multi-wait-submitted-signaled
[128.387358] Subtest multi-wait-submitted-signaled: SUCCESS (0.001s)
[128.477966] [016/133] (893s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-mmap-cpu)
[128.561163] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-mmap-cpu
[128.564553] Subtest fbc-2p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[128.659940] [017/133] (893s left) gem_linear_blits (basic)
[129.053353] Starting subtest: basic
[129.063243] Subtest basic: SUCCESS (0.014s)
[129.207655] [018/133] (892s left) kms_plane (pixel-format-4-tiled-dg2-rc-ccs-cc-modifier-source-clamping)
[129.336974] Starting subtest: pixel-format-4-tiled-dg2-rc-ccs-cc-modifier-source-clamping
[129.340905] Subtest pixel-format-4-tiled-dg2-rc-ccs-cc-modifier-source-clamping: SKIP (0.000s)
[129.409790] [019/133] (892s left) kms_frontbuffer_tracking (psr-2p-scndscrn-shrfb-plflip-blt)
[129.510493] Starting subtest: psr-2p-scndscrn-shrfb-plflip-blt
[129.515144] Subtest psr-2p-scndscrn-shrfb-plflip-blt: SKIP (0.000s)
[129.618250] [020/133] (892s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-mmap-wc)
[129.726127] Starting subtest: psr-2p-primscrn-pri-indfb-draw-mmap-wc
[129.730381] Subtest psr-2p-primscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[129.830215] [021/133] (892s left) i915_selftest (live)
[133.154451] Starting subtest: live
[133.157701] Starting dynamic subtest: sanitycheck
[137.511867] Dynamic subtest sanitycheck: SUCCESS (4.355s)
[137.521240] Starting dynamic subtest: uncore
[141.818642] Dynamic subtest uncore: SUCCESS (4.305s)
[141.828023] Starting dynamic subtest: workarounds
[144.861420] Dynamic subtest workarounds: SUCCESS (3.040s)
[144.871044] Starting dynamic subtest: gt_engines
[147.848970] Dynamic subtest gt_engines: SUCCESS (2.987s)
[147.857828] Starting dynamic subtest: gt_timelines
[163.325192] Dynamic subtest gt_timelines: SUCCESS (15.476s)
[163.334104] Starting dynamic subtest: gt_contexts
[166.064260] Dynamic subtest gt_contexts: SUCCESS (2.738s)
[166.072815] Starting dynamic subtest: gt_lrc
[172.171984] Dynamic subtest gt_lrc: SUCCESS (6.104s)
[172.180981] Starting dynamic subtest: gt_mocs
[175.104393] Dynamic subtest gt_mocs: SUCCESS (2.931s)
[175.118475] Starting dynamic subtest: gt_pm
[181.826940] Dynamic subtest gt_pm: SUCCESS (6.720s)
[181.836840] Starting dynamic subtest: gt_heartbeat
[186.130154] Dynamic subtest gt_heartbeat: SUCCESS (4.301s)
[186.142725] Starting dynamic subtest: gt_tlb
[195.444212] Dynamic subtest gt_tlb: SUCCESS (9.312s)
[195.453671] Starting dynamic subtest: requests
[206.944607] Dynamic subtest requests: SUCCESS (11.497s)
[206.953611] Starting dynamic subtest: migrate
[214.722086] Dynamic subtest migrate: SUCCESS (7.775s)
[214.730966] Starting dynamic subtest: active
[219.043636] Dynamic subtest active: SUCCESS (4.320s)
[219.058024] Starting dynamic subtest: objects
[223.738409] Dynamic subtest objects: SUCCESS (4.693s)
[223.747703] Starting dynamic subtest: mman
[227.177845] Dynamic subtest mman: SUCCESS (3.437s)
[227.186988] Starting dynamic subtest: dmabuf
[231.485765] Dynamic subtest dmabuf: SUCCESS (4.306s)
[231.494922] Starting dynamic subtest: vma
[235.855934] Dynamic subtest vma: SUCCESS (4.369s)
[235.865210] Starting dynamic subtest: coherency
[240.833088] Dynamic subtest coherency: SUCCESS (4.975s)
[240.842857] Starting dynamic subtest: gtt
[250.874568] Dynamic subtest gtt: SUCCESS (10.038s)
[250.883688] Starting dynamic subtest: gem
[258.660459] Dynamic subtest gem: SUCCESS (7.784s)
[258.669873] Starting dynamic subtest: evict
[264.170060] Dynamic subtest evict: SUCCESS (5.508s)
[264.179340] Starting dynamic subtest: hugepages
[272.788607] Dynamic subtest hugepages: SUCCESS (8.616s)
[272.801998] Starting dynamic subtest: gem_contexts
[299.392463] Dynamic subtest gem_contexts: SUCCESS (26.603s)
[299.402204] Starting dynamic subtest: client
[302.075367] Dynamic subtest client: SUCCESS (2.682s)
[302.084560] Starting dynamic subtest: gem_migrate
[306.414412] Dynamic subtest gem_migrate: SUCCESS (4.338s)
[306.423143] Starting dynamic subtest: reset
[310.734057] Dynamic subtest reset: SUCCESS (4.318s)
[310.743853] Starting dynamic subtest: memory_region
[315.079037] Dynamic subtest memory_region: SUCCESS (4.342s)
[315.088246] Starting dynamic subtest: hangcheck
[328.380372] Dynamic subtest hangcheck: SUCCESS (13.299s)
[328.389307] Starting dynamic subtest: execlists
[332.753097] Dynamic subtest execlists: SUCCESS (4.371s)
[332.762073] Starting dynamic subtest: ring_submission
[337.062916] Dynamic subtest ring_submission: SUCCESS (4.308s)
[337.071934] Starting dynamic subtest: perf
[339.839905] Dynamic subtest perf: SUCCESS (2.775s)
[339.848741] Starting dynamic subtest: slpc
[351.815403] Dynamic subtest slpc: SUCCESS (11.973s)
[351.829221] Starting dynamic subtest: guc
[355.728599] Dynamic subtest guc: SUCCESS (3.911s)
[355.740315] Starting dynamic subtest: guc_multi_lrc
[360.066439] Dynamic subtest guc_multi_lrc: SUCCESS (4.336s)
[360.075603] Starting dynamic subtest: guc_hang
[364.960673] Dynamic subtest guc_hang: SUCCESS (4.891s)
[364.970108] Starting dynamic subtest: late_gt_pm
[369.260902] Dynamic subtest late_gt_pm: SUCCESS (4.299s)
[369.263524] Subtest live: SUCCESS (236.094s)
[369.288709] [FACT i915_selftest (live)] deleted: kernel.kmod_is_loaded.i915: true
[369.292124] [022/133] (652s left) kms_frontbuffer_tracking (psr-2p-scndscrn-indfb-pgflip-blt)
[370.885258] Starting subtest: psr-2p-scndscrn-indfb-pgflip-blt
[370.889220] Subtest psr-2p-scndscrn-indfb-pgflip-blt: SKIP (0.000s)
[370.978082] [FACT kms_frontbuffer_tracking (psr-2p-scndscrn-indfb-pgflip-blt)] new: kernel.kmod_is_loaded.i915: true
[370.981719] [023/133] (651s left) gem_pread (display)
[371.041292] Subtest display: SKIP (0.000s)
[371.106975] [024/133] (651s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-mmap-gtt)
[371.208702] Starting subtest: fbc-rgb101010-draw-mmap-gtt
[371.213103] Subtest fbc-rgb101010-draw-mmap-gtt: SKIP (0.000s)
[371.301388] [025/133] (651s left) kms_frontbuffer_tracking (fbc-rgb565-draw-mmap-gtt)
[371.399670] Starting subtest: fbc-rgb565-draw-mmap-gtt
[371.403715] Subtest fbc-rgb565-draw-mmap-gtt: SKIP (0.000s)
[371.498092] [026/133] (650s left) gem_exec_nop (basic-series)
[371.566075] Starting subtest: basic-series
[387.930052] Subtest basic-series: SUCCESS (16.369s)
[388.153373] [027/133] (634s left) kms_psr (fbc-psr2-sprite-plane-move)
[388.259037] Starting subtest: fbc-psr2-sprite-plane-move
[388.261255] Starting dynamic subtest: eDP-1
[388.265264] Dynamic subtest eDP-1: SKIP (0.000s)
[388.269267] Subtest fbc-psr2-sprite-plane-move: SKIP (0.001s)
[388.329340] [028/133] (634s left) syncobj_wait (wait-for-submit-delayed-submit)
[388.399909] Starting subtest: wait-for-submit-delayed-submit
[388.501086] Subtest wait-for-submit-delayed-submit: SUCCESS (0.103s)
[388.592752] [029/133] (633s left) kms_pm_dc (dc5-dpms)
[389.708065] Starting subtest: dc5-dpms
[391.776534] Subtest dc5-dpms: SUCCESS (2.068s)
[391.863558] [030/133] (630s left) kms_psr (fbc-pr-primary-mmap-cpu)
[391.970280] Starting subtest: fbc-pr-primary-mmap-cpu
[391.974929] Subtest fbc-pr-primary-mmap-cpu: SKIP (0.000s)
[392.049368] [031/133] (630s left) kms_cursor_crc (cursor-random-512x512)
[392.408842] Starting subtest: cursor-random-512x512
[392.412946] Subtest cursor-random-512x512: SKIP (0.001s)
[392.579304] [032/133] (630s left) api_intel_allocator (alloc-simple)
[392.637065] Starting subtest: alloc-simple
[392.639432] Subtest alloc-simple: SUCCESS (0.003s)
[392.759565] [033/133] (629s left) kms_flip (wf_vblank-ts-check)
[392.851163] Starting subtest: wf_vblank-ts-check
[392.853010] Starting dynamic subtest: A-eDP1
[401.773232] Dynamic subtest A-eDP1: SUCCESS (8.919s)
[401.784836] Starting dynamic subtest: B-eDP1
[410.707667] Dynamic subtest B-eDP1: SUCCESS (8.932s)
[410.717134] Starting dynamic subtest: C-eDP1
[419.634652] Dynamic subtest C-eDP1: SUCCESS (8.923s)
[419.642899] Starting dynamic subtest: D-eDP1
[428.563572] Dynamic subtest D-eDP1: SUCCESS (8.927s)
[428.566031] Subtest wf_vblank-ts-check: SUCCESS (35.712s)
[429.806970] [034/133] (592s left) gem_exec_balancer (waits)
[429.872076] Starting subtest: waits
[436.423877] Subtest waits: SUCCESS (6.549s)
[436.733237] [035/133] (586s left) kms_psr2_sf (psr2-cursor-plane-move-continuous-sf)
[436.837646] Starting subtest: psr2-cursor-plane-move-continuous-sf
[436.839882] Starting dynamic subtest: pipe-A-eDP-1
[447.261044] Dynamic subtest pipe-A-eDP-1: SUCCESS (10.418s)
[447.270280] Starting dynamic subtest: pipe-B-eDP-1
[458.358165] Dynamic subtest pipe-B-eDP-1: SUCCESS (11.097s)
[458.360548] Subtest psr2-cursor-plane-move-continuous-sf: SUCCESS (21.520s)
[459.159741] [036/133] (563s left) api_intel_bb (object-noreloc-keep-cache-simple)
[459.212874] Starting subtest: object-noreloc-keep-cache-simple
[459.216125] Subtest object-noreloc-keep-cache-simple: SUCCESS (0.005s)
[459.354623] [037/133] (563s left) gem_mmap_wc (read)
[459.415414] Subtest read: SKIP (0.000s)
[459.467423] [038/133] (563s left) gem_exec_suspend (basic-s3)
[459.523267] Starting subtest: basic-S3
[459.525518] Starting dynamic subtest: smem
[479.281327] Dynamic subtest smem: SUCCESS (6.296s)
[479.284118] Subtest basic-S3: SUCCESS (6.298s)
[479.487061] [039/133] (543s left) kms_invalid_mode (overflow-vrefresh)
[479.600822] Starting subtest: overflow-vrefresh
[479.603184] Starting dynamic subtest: pipe-A-eDP-1
[479.897285] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.285s)
[479.911161] Starting dynamic subtest: pipe-B-eDP-1
[479.913441] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[479.922130] Starting dynamic subtest: pipe-C-eDP-1
[479.924464] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[479.932961] Starting dynamic subtest: pipe-D-eDP-1
[479.935268] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[479.937436] Subtest overflow-vrefresh: SUCCESS (0.291s)
[480.801553] [040/133] (542s left) sriov_basic (enable-vfs-bind-unbind-each)
[480.871363] Starting subtest: enable-vfs-bind-unbind-each
[480.873902] Starting dynamic subtest: numvfs-1
[480.957983] Dynamic subtest numvfs-1: FAIL (0.031s)
[480.968347] Starting dynamic subtest: numvfs-2
[481.042531] Dynamic subtest numvfs-2: FAIL (0.004s)
[481.054249] Starting dynamic subtest: numvfs-3
[481.129052] Dynamic subtest numvfs-3: FAIL (0.003s)
[481.139061] Starting dynamic subtest: numvfs-4
[481.213033] Dynamic subtest numvfs-4: FAIL (0.004s)
[481.224325] Starting dynamic subtest: numvfs-5
[481.298189] Dynamic subtest numvfs-5: FAIL (0.003s)
[481.308358] Starting dynamic subtest: numvfs-6
[481.382937] Dynamic subtest numvfs-6: FAIL (0.004s)
[481.394009] Starting dynamic subtest: numvfs-7
[481.468422] Dynamic subtest numvfs-7: FAIL (0.004s)
[481.478037] Starting dynamic subtest: numvfs-random
[481.551825] Dynamic subtest numvfs-random: FAIL (0.004s)
[481.554260] Subtest enable-vfs-bind-unbind-each: FAIL (0.062s)
[481.593311] [041/133] (541s left) kms_big_fb (yf-tiled-64bpp-rotate-0)
[481.695327] Starting subtest: yf-tiled-64bpp-rotate-0
[481.699957] Subtest yf-tiled-64bpp-rotate-0: SKIP (0.000s)
[481.799132] [042/133] (541s left) perf_pmu (all-busy-idle-check-all)
[481.839025] Starting subtest: all-busy-idle-check-all
[482.561479] Subtest all-busy-idle-check-all: FAIL (0.631s)
[483.317943] [043/133] (539s left) kms_vblank (ts-continuation-modeset-rpm)
[483.404455] Starting subtest: ts-continuation-modeset-rpm
[483.406783] Starting dynamic subtest: pipe-A-eDP-1
[485.928226] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.472s)
[485.946348] Starting dynamic subtest: pipe-D-eDP-1
[488.210929] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.245s)
[488.212926] Subtest ts-continuation-modeset-rpm: SUCCESS (4.722s)
[489.007459] [044/133] (534s left) perf_pmu (init-sema)
[489.054033] Starting subtest: init-sema
[489.056278] Starting dynamic subtest: rcs0
[489.058424] Dynamic subtest rcs0: SUCCESS (0.001s)
[489.068268] Starting dynamic subtest: bcs0
[489.070404] Dynamic subtest bcs0: SUCCESS (0.000s)
[489.079306] Starting dynamic subtest: vcs0
[489.081479] Dynamic subtest vcs0: SUCCESS (0.001s)
[489.090342] Starting dynamic subtest: vcs1
[489.092537] Dynamic subtest vcs1: SUCCESS (0.001s)
[489.101703] Starting dynamic subtest: vecs0
[489.103638] Dynamic subtest vecs0: SUCCESS (0.000s)
[489.112584] Starting dynamic subtest: ccs0
[489.114818] Dynamic subtest ccs0: SUCCESS (0.000s)
[489.117087] Subtest init-sema: SUCCESS (0.008s)
[489.157947] [045/133] (534s left) gem_ctx_shared (q-smoketest-all)
[489.218358] Starting subtest: Q-smoketest-all
[521.711885] Subtest Q-smoketest-all: SUCCESS (32.349s)
[523.415639] [046/133] (499s left) kms_plane (pixel-format-x-tiled-modifier-source-clamping)
[523.512624] Starting subtest: pixel-format-x-tiled-modifier-source-clamping
[523.540031] Starting dynamic subtest: pipe-A-plane-0
[524.218451] Dynamic subtest pipe-A-plane-0: SUCCESS (0.678s)
[524.230773] Starting dynamic subtest: pipe-A-plane-3
[524.629222] Dynamic subtest pipe-A-plane-3: SUCCESS (0.408s)
[525.718219] Starting dynamic subtest: pipe-B-plane-0
[526.332661] Dynamic subtest pipe-B-plane-0: SUCCESS (0.622s)
[526.342641] Starting dynamic subtest: pipe-B-plane-3
[526.754946] Dynamic subtest pipe-B-plane-3: SUCCESS (0.421s)
[527.069114] Subtest pixel-format-x-tiled-modifier-source-clamping: SUCCESS (3.553s)
[527.894923] [047/133] (495s left) i915_pciid
[528.025754] [048/133] (495s left) kms_plane_scaling (planes-upscale-factor-0-25-downscale-factor-0-5)
[528.113971] Starting subtest: planes-upscale-factor-0-25-downscale-factor-0-5
[528.116271] Starting dynamic subtest: pipe-A
[528.135461] Dynamic subtest pipe-A: SKIP (0.019s)
[528.145242] Starting dynamic subtest: pipe-B
[528.169781] Dynamic subtest pipe-B: SKIP (0.032s)
[528.179455] Starting dynamic subtest: pipe-C
[528.200932] Dynamic subtest pipe-C: SKIP (0.032s)
[528.210253] Starting dynamic subtest: pipe-D
[528.235269] Dynamic subtest pipe-D: SKIP (0.032s)
[528.239472] Subtest planes-upscale-factor-0-25-downscale-factor-0-5: SKIP (0.117s)
[528.336487] [049/133] (494s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-gtt)
[528.426664] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-gtt
[528.431210] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[528.535259] [050/133] (494s left) gem_exec_fence (syncobj-export)
[529.032781] Starting subtest: syncobj-export
[529.035236] Subtest syncobj-export: SUCCESS (0.006s)
[530.372314] [FACT gem_exec_fence (syncobj-export)] new: kernel.kmod_is_loaded.vgem: true
[530.376211] [051/133] (493s left) kms_chamelium_color (ctm-0-25)
[530.475886] Subtest ctm-0-25: SKIP (0.000s)
[530.522508] [052/133] (492s left) gem_mmap_gtt (basic-short)
[530.578802] Subtest basic-short: SKIP (0.000s)
[530.654084] [053/133] (492s left) kms_cursor_crc (cursor-size-change)
[530.745315] Starting subtest: cursor-size-change
[530.747616] Starting dynamic subtest: pipe-A-eDP-1
[531.581479] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.835s)
[531.591858] Starting dynamic subtest: pipe-D-eDP-1
[533.064056] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.477s)
[533.066005] Subtest cursor-size-change: SUCCESS (2.316s)
[533.860168] [054/133] (489s left) kms_ccs (crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc)
[533.950667] Starting subtest: crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc
[533.952869] Starting dynamic subtest: pipe-A-eDP-1
[534.009948] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[534.021704] Starting dynamic subtest: pipe-B-eDP-1
[534.077871] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[534.090216] Starting dynamic subtest: pipe-C-eDP-1
[534.147883] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[534.158289] Starting dynamic subtest: pipe-D-eDP-1
[534.213838] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[534.218166] Subtest crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc: SKIP (0.009s)
[536.227122] [055/133] (487s left) gem_pwrite (basic-exhaustion)
[536.293930] Subtest basic-exhaustion: SKIP (0.000s)
[536.348020] [056/133] (487s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-mmap-cpu)
[536.439131] Starting subtest: psr-1p-primscrn-spr-indfb-draw-mmap-cpu
[543.265356] Subtest psr-1p-primscrn-spr-indfb-draw-mmap-cpu: SUCCESS (6.825s)
[543.417781] [057/133] (480s left) kms_flip (2x-flip-vs-expired-vblank-interruptible)
[543.524783] Starting subtest: 2x-flip-vs-expired-vblank-interruptible
[543.536198] Subtest 2x-flip-vs-expired-vblank-interruptible: SKIP (0.011s)
[543.611785] [058/133] (480s left) kms_frontbuffer_tracking (psr-1p-pri-indfb-multidraw)
[543.708900] Starting subtest: psr-1p-pri-indfb-multidraw
[566.556114] Subtest psr-1p-pri-indfb-multidraw: SUCCESS (22.838s)
[566.681096] [059/133] (457s left) fbdev (info)
[566.723679] Starting subtest: info
[566.725345] Subtest info: SUCCESS (0.000s)
[566.791162] [060/133] (457s left) kms_ccs (bad-rotation-90-4-tiled-mtl-rc-ccs-cc)
[566.882268] Starting subtest: bad-rotation-90-4-tiled-mtl-rc-ccs-cc
[566.884205] Starting dynamic subtest: pipe-A-eDP-1
[567.036149] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.146s)
[567.047806] Starting dynamic subtest: pipe-B-eDP-1
[567.064456] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.010s)
[567.076917] Starting dynamic subtest: pipe-C-eDP-1
[567.094781] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.012s)
[567.104167] Starting dynamic subtest: pipe-D-eDP-1
[567.120434] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.011s)
[567.122029] Subtest bad-rotation-90-4-tiled-mtl-rc-ccs-cc: SUCCESS (0.184s)
[569.384784] [061/133] (454s left) gem_ppgtt (flink-and-close-vma-leak)
[569.433702] Starting subtest: flink-and-close-vma-leak
[569.476446] Subtest flink-and-close-vma-leak: SUCCESS (0.042s)
[569.600985] [062/133] (454s left) gem_exec_balancer (bonded-pair)
[569.669211] Starting subtest: bonded-pair
[569.673691] Subtest bonded-pair: SKIP (0.000s)
[569.970197] [063/133] (453s left) syncobj_timeline (invalid-query-zero-handles)
[570.033907] Starting subtest: invalid-query-zero-handles
[570.035933] Subtest invalid-query-zero-handles: SUCCESS (0.000s)
[570.131392] [064/133] (453s left) gem_caching (writes)
[570.203140] Subtest writes: SKIP (0.000s)
[570.276107] [065/133] (453s left) kms_getfb (getfb2-accept-nv12)
[570.376741] Starting subtest: getfb2-accept-nv12
[570.378875] Subtest getfb2-accept-nv12: SUCCESS (0.001s)
[570.494253] [066/133] (453s left) gem_exec_schedule (pi-distinct-iova)
[570.676096] Starting subtest: pi-distinct-iova
[570.678788] Starting dynamic subtest: rcs0
[570.759477] Dynamic subtest rcs0: SUCCESS (0.086s)
[570.771207] Starting dynamic subtest: vcs0
[570.817961] Dynamic subtest vcs0: SUCCESS (0.058s)
[570.832005] Starting dynamic subtest: vcs1
[570.873195] Dynamic subtest vcs1: SUCCESS (0.054s)
[570.888926] Starting dynamic subtest: vecs0
[570.928520] Dynamic subtest vecs0: SUCCESS (0.054s)
[570.939954] Starting dynamic subtest: ccs0
[570.989036] Dynamic subtest ccs0: SUCCESS (0.059s)
[570.991929] Subtest pi-distinct-iova: SUCCESS (0.316s)
[572.440209] [067/133] (451s left) kms_ccs (crc-primary-suspend-4-tiled-dg2-rc-ccs-cc)
[572.533592] Starting subtest: crc-primary-suspend-4-tiled-dg2-rc-ccs-cc
[572.535905] Starting dynamic subtest: pipe-A-eDP-1
[572.544880] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[572.558670] Starting dynamic subtest: pipe-B-eDP-1
[572.567549] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[572.577386] Starting dynamic subtest: pipe-C-eDP-1
[572.586073] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[572.595473] Starting dynamic subtest: pipe-D-eDP-1
[572.604124] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[572.608435] Subtest crc-primary-suspend-4-tiled-dg2-rc-ccs-cc: SKIP (0.005s)
[574.861664] [068/133] (449s left) kms_chamelium_frames (hdmi-crc-nonplanar-formats)
[575.246627] Subtest hdmi-crc-nonplanar-formats: SKIP (0.000s)
[576.058224] [069/133] (448s left) syncobj_timeline (single-wait-signaled)
[576.116664] Starting subtest: single-wait-signaled
[576.118904] Subtest single-wait-signaled: SUCCESS (0.000s)
[576.210516] [070/133] (448s left) kms_flip (nonexisting-fb-interruptible)
[576.313844] Starting subtest: nonexisting-fb-interruptible
[576.316113] Starting dynamic subtest: A-eDP1
[577.464026] Dynamic subtest A-eDP1: SUCCESS (1.149s)
[577.474972] Starting dynamic subtest: B-eDP1
[578.608713] Dynamic subtest B-eDP1: SUCCESS (1.144s)
[578.624937] Starting dynamic subtest: C-eDP1
[579.740819] Dynamic subtest C-eDP1: SUCCESS (1.131s)
[579.754772] Starting dynamic subtest: D-eDP1
[580.876557] Dynamic subtest D-eDP1: SUCCESS (1.134s)
[580.879057] Subtest nonexisting-fb-interruptible: SUCCESS (4.568s)
[582.056998] [071/133] (442s left) gem_exec_schedule (preempt-self)
[582.125848] Starting subtest: preempt-self
[582.127997] Starting dynamic subtest: rcs0
[582.137977] Dynamic subtest rcs0: SUCCESS (0.019s)
[582.148795] Starting dynamic subtest: bcs0
[582.156068] Dynamic subtest bcs0: SUCCESS (0.017s)
[582.170468] Starting dynamic subtest: vcs0
[582.177313] Dynamic subtest vcs0: SUCCESS (0.020s)
[582.186749] Starting dynamic subtest: vcs1
[582.195141] Dynamic subtest vcs1: SUCCESS (0.017s)
[582.210151] Starting dynamic subtest: vecs0
[582.219835] Dynamic subtest vecs0: SUCCESS (0.024s)
[582.232741] Starting dynamic subtest: ccs0
[582.238138] Dynamic subtest ccs0: SUCCESS (0.015s)
[582.240657] Subtest preempt-self: SUCCESS (0.118s)
[583.398101] [072/133] (440s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-0)
[583.506414] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-0
[584.528995] Subtest x-tiled-max-hw-stride-64bpp-rotate-0: SUCCESS (1.023s)
[584.665245] [073/133] (439s left) kms_ccs (bad-aux-stride-4-tiled-mtl-rc-ccs)
[584.765076] Starting subtest: bad-aux-stride-4-tiled-mtl-rc-ccs
[584.767330] Starting dynamic subtest: pipe-A-eDP-1
[584.785055] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[584.796203] Starting dynamic subtest: pipe-B-eDP-1
[584.812062] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[584.821603] Starting dynamic subtest: pipe-C-eDP-1
[584.836808] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[584.845765] Starting dynamic subtest: pipe-D-eDP-1
[584.861448] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[584.863017] Subtest bad-aux-stride-4-tiled-mtl-rc-ccs: SUCCESS (0.008s)
[587.013949] [074/133] (437s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-32bpp-ytile-upscaling)
[587.119165] Starting subtest: flip-64bpp-ytile-to-32bpp-ytile-upscaling
[587.123539] Subtest flip-64bpp-ytile-to-32bpp-ytile-upscaling: SKIP (0.000s)
[587.189688] [075/133] (437s left) kms_ccs (ccs-on-another-bo-y-tiled-ccs)
[587.283446] Starting subtest: ccs-on-another-bo-y-tiled-ccs
[587.285727] Starting dynamic subtest: pipe-A-eDP-1
[587.307871] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[587.321733] Starting dynamic subtest: pipe-B-eDP-1
[587.342286] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[587.352269] Starting dynamic subtest: pipe-C-eDP-1
[587.373146] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[587.382503] Starting dynamic subtest: pipe-D-eDP-1
[587.404102] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[587.408366] Subtest ccs-on-another-bo-y-tiled-ccs: SKIP (0.005s)
[589.795917] [076/133] (434s left) kms_big_fb (linear-64bpp-rotate-180)
[589.895945] Starting subtest: linear-64bpp-rotate-180
[591.486475] Subtest linear-64bpp-rotate-180: SUCCESS (1.590s)
[591.650655] [077/133] (432s left) kms_flip (modeset-vs-vblank-race-interruptible)
[591.763338] Starting subtest: modeset-vs-vblank-race-interruptible
[591.765710] Starting dynamic subtest: A-eDP1
[596.421336] Dynamic subtest A-eDP1: SUCCESS (4.657s)
[596.437502] Starting dynamic subtest: B-eDP1
[601.066926] Dynamic subtest B-eDP1: SUCCESS (4.643s)
[601.083904] Starting dynamic subtest: C-eDP1
[605.778305] Dynamic subtest C-eDP1: SUCCESS (4.709s)
[605.792340] Starting dynamic subtest: D-eDP1
[610.326261] Dynamic subtest D-eDP1: SUCCESS (4.544s)
[610.331082] Subtest modeset-vs-vblank-race-interruptible: SUCCESS (18.568s)
[611.494483] [078/133] (413s left) gem_spin_batch (legacy)
[611.560626] Starting subtest: legacy
[611.562899] Starting dynamic subtest: default
[614.800803] Dynamic subtest default: SUCCESS (3.234s)
[614.811249] Starting dynamic subtest: render
[618.039638] Dynamic subtest render: SUCCESS (3.234s)
[618.049909] Starting dynamic subtest: bsd
[621.275797] Dynamic subtest bsd: SUCCESS (3.233s)
[621.288248] Starting dynamic subtest: bsd1
[624.511900] Dynamic subtest bsd1: SUCCESS (3.233s)
[624.524081] Starting dynamic subtest: bsd2
[627.749417] Dynamic subtest bsd2: SUCCESS (3.234s)
[627.760106] Starting dynamic subtest: blt
[630.988532] Dynamic subtest blt: SUCCESS (3.235s)
[630.999444] Starting dynamic subtest: vebox
[634.225952] Dynamic subtest vebox: SUCCESS (3.232s)
[634.228329] Subtest legacy: SUCCESS (22.657s)
[634.411663] [079/133] (390s left) kms_atomic_interruptible (universal-setplane-cursor)
[634.510347] Starting subtest: universal-setplane-cursor
[634.512689] Starting dynamic subtest: pipe-A-eDP-1
[641.894601] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.381s)
[641.896881] Subtest universal-setplane-cursor: SUCCESS (7.383s)
[642.744115] [080/133] (381s left) i915_drm_fdinfo (busy-idle)
[642.786355] Starting subtest: busy-idle
[642.788508] Starting dynamic subtest: rcs0
[642.808071] Dynamic subtest rcs0: SKIP (0.023s)
[642.821168] Starting dynamic subtest: bcs0
[642.828235] Dynamic subtest bcs0: SKIP (0.018s)
[642.838641] Starting dynamic subtest: vcs0
[642.843124] Dynamic subtest vcs0: SKIP (0.001s)
[642.852962] Starting dynamic subtest: vcs1
[642.857530] Dynamic subtest vcs1: SKIP (0.000s)
[642.867513] Starting dynamic subtest: vecs0
[642.872061] Dynamic subtest vecs0: SKIP (0.000s)
[642.881721] Starting dynamic subtest: ccs0
[642.886245] Dynamic subtest ccs0: SKIP (0.000s)
[642.890712] Subtest busy-idle: SKIP (0.048s)
[642.929970] [081/133] (381s left) vgem_basic (dmabuf-mmap)
[642.982155] Starting subtest: dmabuf-mmap
[643.017881] Subtest dmabuf-mmap: SUCCESS (0.038s)
[643.079298] [082/133] (381s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-pwrite)
[643.178855] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-pwrite
[650.062735] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-pwrite: SUCCESS (6.887s)
[650.187289] [083/133] (374s left) kms_feature_discovery (dp-mst)
[650.287927] Starting subtest: dp-mst
[650.292447] Subtest dp-mst: SKIP (0.000s)
[650.364132] [084/133] (374s left) sw_sync (timeline_closed)
[650.404247] Starting subtest: timeline_closed
[650.406558] Subtest timeline_closed: SUCCESS (0.000s)
[650.463559] [085/133] (374s left) kms_cursor_crc (cursor-offscreen-max-size)
[650.775107] Starting subtest: cursor-offscreen-max-size
[650.781630] Subtest cursor-offscreen-max-size: SKIP (0.000s)
[650.903356] [086/133] (373s left) gem_mmap_gtt (cpuset-big-copy)
[650.961932] Subtest cpuset-big-copy: SKIP (0.000s)
[651.024572] [087/133] (373s left) gem_ctx_engines (none)
[651.084326] Starting subtest: none
[651.086393] Subtest none: SUCCESS (0.001s)
[651.275563] [088/133] (373s left) gem_vm_create (invalid-destroy)
[651.339935] Starting subtest: invalid-destroy
[651.342337] Subtest invalid-destroy: SUCCESS (0.002s)
[651.471930] [089/133] (373s left) kms_cursor_legacy (2x-long-cursor-vs-flip-atomic)
[651.591326] Starting subtest: 2x-long-cursor-vs-flip-atomic
[651.595541] Subtest 2x-long-cursor-vs-flip-atomic: SKIP (0.001s)
[651.741083] [090/133] (373s left) gem_exec_schedule (fifo)
[651.815645] Starting subtest: fifo
[651.817642] Starting dynamic subtest: rcs0
[651.906774] Dynamic subtest rcs0: SUCCESS (0.101s)
[651.919887] Starting dynamic subtest: vcs0
[651.992133] Dynamic subtest vcs0: SUCCESS (0.084s)
[652.005111] Starting dynamic subtest: vcs1
[652.076020] Dynamic subtest vcs1: SUCCESS (0.081s)
[652.088094] Starting dynamic subtest: vecs0
[652.152947] Dynamic subtest vecs0: SUCCESS (0.076s)
[652.166072] Starting dynamic subtest: ccs0
[652.235525] Dynamic subtest ccs0: SUCCESS (0.082s)
[652.237680] Subtest fifo: SUCCESS (0.430s)
[653.377543] [091/133] (371s left) kms_color_pipeline (plane-ctm3x4-lut1d)
[653.466141] Starting subtest: plane-ctm3x4-lut1d
[653.657957] Starting dynamic subtest: pipe-A-plane-0
[653.835560] Dynamic subtest pipe-A-plane-0: SUCCESS (0.178s)
[653.846023] Starting dynamic subtest: pipe-A-plane-1
[654.014248] Dynamic subtest pipe-A-plane-1: SUCCESS (0.177s)
[654.024643] Starting dynamic subtest: pipe-A-plane-2
[654.180410] Dynamic subtest pipe-A-plane-2: SUCCESS (0.166s)
[655.396742] Starting dynamic subtest: pipe-B-plane-0
[655.555048] Dynamic subtest pipe-B-plane-0: SUCCESS (0.166s)
[655.565375] Starting dynamic subtest: pipe-B-plane-1
[655.711025] Dynamic subtest pipe-B-plane-1: SUCCESS (0.155s)
[655.724880] Starting dynamic subtest: pipe-B-plane-2
[655.866296] Dynamic subtest pipe-B-plane-2: SUCCESS (0.155s)
[657.120952] Starting dynamic subtest: pipe-C-plane-0
[657.256514] Dynamic subtest pipe-C-plane-0: SUCCESS (0.144s)
[657.267437] Starting dynamic subtest: pipe-C-plane-1
[657.401225] Dynamic subtest pipe-C-plane-1: SUCCESS (0.144s)
[657.411955] Starting dynamic subtest: pipe-C-plane-2
[657.556617] Dynamic subtest pipe-C-plane-2: SUCCESS (0.155s)
[658.740657] Starting dynamic subtest: pipe-D-plane-0
[658.875547] Dynamic subtest pipe-D-plane-0: SUCCESS (0.144s)
[658.886250] Starting dynamic subtest: pipe-D-plane-1
[659.020064] Dynamic subtest pipe-D-plane-1: SUCCESS (0.144s)
[659.030797] Starting dynamic subtest: pipe-D-plane-2
[659.164727] Dynamic subtest pipe-D-plane-2: SUCCESS (0.143s)
[659.467279] Subtest plane-ctm3x4-lut1d: SUCCESS (6.000s)
[660.317754] [092/133] (364s left) kms_lease (page-flip-implicit-plane)
[660.416517] Starting subtest: page-flip-implicit-plane
[660.418462] Starting dynamic subtest: pipe-A-eDP-1
[660.910499] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.495s)
[660.925743] Starting dynamic subtest: pipe-B-eDP-1
[662.057738] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.142s)
[662.072345] Starting dynamic subtest: pipe-C-eDP-1
[663.165646] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.106s)
[663.176569] Starting dynamic subtest: pipe-D-eDP-1
[664.296140] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.130s)
[664.298375] Subtest page-flip-implicit-plane: SUCCESS (3.881s)
[665.134526] [093/133] (360s left) sw_sync (alloc_fence)
[665.173436] Starting subtest: alloc_fence
[665.175660] Subtest alloc_fence: SUCCESS (0.000s)
[665.237214] [094/133] (360s left) syncobj_eventfd (invalid-illegal-handle)
[665.311851] Starting subtest: invalid-illegal-handle
[665.314225] Subtest invalid-illegal-handle: SUCCESS (0.000s)
[665.427548] [095/133] (359s left) gem_reg_read (bad-register)
[665.483362] Starting subtest: bad-register
[665.485634] Subtest bad-register: SUCCESS (0.000s)
[665.586418] [096/133] (359s left) kms_panel_fitting (atomic-fastset)
[665.684868] Starting subtest: atomic-fastset
[665.687125] Starting dynamic subtest: pipe-A-eDP-1
[665.824940] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.141s)
[665.837377] Starting dynamic subtest: pipe-B-eDP-1
[666.997233] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.171s)
[667.011006] Starting dynamic subtest: pipe-C-eDP-1
[668.184828] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.185s)
[668.196871] Starting dynamic subtest: pipe-D-eDP-1
[669.327137] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.142s)
[669.329508] Subtest atomic-fastset: SUCCESS (3.644s)
[670.583099] [097/133] (354s left) kms_psr (psr2-cursor-blt)
[670.689800] Starting subtest: psr2-cursor-blt
[670.692129] Starting dynamic subtest: eDP-1
[672.347610] Dynamic subtest eDP-1: SUCCESS (1.658s)
[672.349912] Subtest psr2-cursor-blt: SUCCESS (1.659s)
[673.152830] [098/133] (352s left) gem_ctx_persistence (heartbeat-many)
[673.215226] Starting subtest: heartbeat-many
[673.219892] Subtest heartbeat-many: SKIP (0.000s)
[673.320798] [099/133] (352s left) kms_cursor_legacy (single-move)
[673.438528] Starting subtest: single-move
[673.440438] Starting dynamic subtest: pipe-A
[678.824251] Dynamic subtest pipe-A: SUCCESS (5.380s)
[678.836773] Starting dynamic subtest: pipe-B
[684.207952] Dynamic subtest pipe-B: SUCCESS (5.379s)
[684.219988] Starting dynamic subtest: pipe-C
[689.591244] Dynamic subtest pipe-C: SUCCESS (5.379s)
[689.603196] Starting dynamic subtest: pipe-D
[694.974927] Dynamic subtest pipe-D: SUCCESS (5.379s)
[694.985198] Starting dynamic subtest: all-pipes
[700.366161] Dynamic subtest all-pipes: SUCCESS (5.385s)
[700.368740] Subtest single-move: SUCCESS (26.916s)
[700.513775] [100/133] (325s left) kms_cursor_legacy (basic-flip-before-cursor-atomic)
[700.645447] Starting subtest: basic-flip-before-cursor-atomic
[701.566420] Subtest basic-flip-before-cursor-atomic: SUCCESS (0.922s)
[702.390120] [101/133] (323s left) kms_psr (fbc-psr2-primary-mmap-cpu)
[702.477193] Starting subtest: fbc-psr2-primary-mmap-cpu
[702.479493] Starting dynamic subtest: eDP-1
[702.483751] Dynamic subtest eDP-1: SKIP (0.000s)
[702.488007] Subtest fbc-psr2-primary-mmap-cpu: SKIP (0.001s)
[702.565597] [102/133] (323s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-blt)
[702.660624] Starting subtest: fbcpsr-rgb101010-draw-blt
[709.523089] Subtest fbcpsr-rgb101010-draw-blt: SUCCESS (6.869s)
[709.652952] [103/133] (315s left) kms_selftest (drm_format)
[709.696935] Starting subtest: drm_format
[709.717309] Starting dynamic subtest: drm_test_format_block_width_invalid
[709.827474] Dynamic subtest drm_test_format_block_width_invalid: SUCCESS (0.109s)
[709.839216] Starting dynamic subtest: drm_test_format_block_width_one_plane
[709.914547] Dynamic subtest drm_test_format_block_width_one_plane: SUCCESS (0.087s)
[709.925241] Starting dynamic subtest: drm_test_format_block_width_two_plane
[710.024338] Dynamic subtest drm_test_format_block_width_two_plane: SUCCESS (0.109s)
[710.035575] Starting dynamic subtest: drm_test_format_block_width_three_plane
[710.115250] Dynamic subtest drm_test_format_block_width_three_plane: SUCCESS (0.090s)
[710.126800] Starting dynamic subtest: drm_test_format_block_width_tiled
[710.210443] Dynamic subtest drm_test_format_block_width_tiled: SUCCESS (0.094s)
[710.221770] Starting dynamic subtest: drm_test_format_block_height_invalid
[710.325428] Dynamic subtest drm_test_format_block_height_invalid: SUCCESS (0.114s)
[710.336281] Starting dynamic subtest: drm_test_format_block_height_one_plane
[710.426283] Dynamic subtest drm_test_format_block_height_one_plane: SUCCESS (0.101s)
[710.436838] Starting dynamic subtest: drm_test_format_block_height_two_plane
[710.513987] Dynamic subtest drm_test_format_block_height_two_plane: SUCCESS (0.087s)
[710.524763] Starting dynamic subtest: drm_test_format_block_height_three_plane
[710.617482] Dynamic subtest drm_test_format_block_height_three_plane: SUCCESS (0.103s)
[710.629266] Starting dynamic subtest: drm_test_format_block_height_tiled
[710.719020] Dynamic subtest drm_test_format_block_height_tiled: SUCCESS (0.101s)
[710.728248] Starting dynamic subtest: drm_test_format_min_pitch_invalid
[710.822143] Dynamic subtest drm_test_format_min_pitch_invalid: SUCCESS (0.101s)
[710.832761] Starting dynamic subtest: drm_test_format_min_pitch_one_plane_8bpp
[710.915493] Dynamic subtest drm_test_format_min_pitch_one_plane_8bpp: SUCCESS (0.093s)
[710.924838] Starting dynamic subtest: drm_test_format_min_pitch_one_plane_16bpp
[711.014153] Dynamic subtest drm_test_format_min_pitch_one_plane_16bpp: SUCCESS (0.097s)
[711.025666] Starting dynamic subtest: drm_test_format_min_pitch_one_plane_24bpp
[711.109229] Dynamic subtest drm_test_format_min_pitch_one_plane_24bpp: SUCCESS (0.095s)
[711.120374] Starting dynamic subtest: drm_test_format_min_pitch_one_plane_32bpp
[711.219280] Dynamic subtest drm_test_format_min_pitch_one_plane_32bpp: SUCCESS (0.109s)
[711.230596] Starting dynamic subtest: drm_test_format_min_pitch_two_plane
[711.312052] Dynamic subtest drm_test_format_min_pitch_two_plane: SUCCESS (0.092s)
[711.323284] Starting dynamic subtest: drm_test_format_min_pitch_three_plane_8bpp
[711.402518] Dynamic subtest drm_test_format_min_pitch_three_plane_8bpp: SUCCESS (0.090s)
[711.413265] Starting dynamic subtest: drm_test_format_min_pitch_tiled
[711.507654] Dynamic subtest drm_test_format_min_pitch_tiled: SUCCESS (0.104s)
[711.509331] Subtest drm_format: SUCCESS (1.810s)
[711.672891] [104/133] (314s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-mmap-wc)
[711.771044] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-mmap-wc
[711.774866] Subtest fbc-2p-scndscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[711.862630] [105/133] (313s left) kms_psr (psr2-sprite-mmap-gtt)
[711.939890] Starting subtest: psr2-sprite-mmap-gtt
[711.941863] Starting dynamic subtest: eDP-1
[713.397019] Dynamic subtest eDP-1: SKIP (1.453s)
[713.402719] Subtest psr2-sprite-mmap-gtt: SKIP (1.455s)
[713.518135] [106/133] (312s left) syncobj_wait (invalid-multi-wait-unsubmitted-submitted-signaled)
[713.570080] Starting subtest: invalid-multi-wait-unsubmitted-submitted-signaled
[713.572409] Subtest invalid-multi-wait-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[713.684361] [107/133] (312s left) gem_render_copy (y-tiled-to-vebox-linear)
[713.743445] Starting subtest: y-tiled-to-vebox-linear
[713.747351] Subtest y-tiled-to-vebox-linear: SKIP (0.000s)
[713.943062] [108/133] (311s left) gem_eio (wait-wedge-1us)
[714.173925] Starting subtest: wait-wedge-1us
[715.387809] Subtest wait-wedge-1us: SUCCESS (1.212s)
[715.520970] [109/133] (310s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-180-async-flip)
[715.634945] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-180-async-flip
[715.639370] Subtest yf-tiled-max-hw-stride-64bpp-rotate-180-async-flip: SKIP (0.000s)
[715.731335] [110/133] (310s left) kms_frontbuffer_tracking (fbc-1p-primscrn-indfb-pgflip-blt)
[715.847541] Starting subtest: fbc-1p-primscrn-indfb-pgflip-blt
[720.276834] Subtest fbc-1p-primscrn-indfb-pgflip-blt: SUCCESS (4.434s)
[721.434569] [111/133] (304s left) kms_atomic (plane-overlay-legacy)
[721.524104] Starting subtest: plane-overlay-legacy
[721.526548] Starting dynamic subtest: pipe-A-eDP-1
[721.937677] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.414s)
[721.939873] Subtest plane-overlay-legacy: SUCCESS (0.415s)
[722.740711] [112/133] (303s left) perf (gen12-group-concurrent-oa-buffer-read)
[722.890939] Starting subtest: gen12-group-concurrent-oa-buffer-read
[732.931595] Subtest gen12-group-concurrent-oa-buffer-read: SUCCESS (10.041s)
[732.981519] [113/133] (293s left) gem_fence_thrash (bo-write-verify-threaded-x)
[733.024264] Starting subtest: bo-write-verify-threaded-x
[733.045342] Subtest bo-write-verify-threaded-x: SKIP (0.019s)
[733.118449] [114/133] (293s left) syncobj_wait (wait-zero-handles)
[733.177195] Starting subtest: wait-zero-handles
[733.179491] Subtest wait-zero-handles: SUCCESS (0.000s)
[733.290630] [115/133] (292s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-180)
[733.403830] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-180
[734.483822] Subtest 4-tiled-max-hw-stride-32bpp-rotate-180: SUCCESS (1.080s)
[734.607354] [116/133] (291s left) kms_big_fb (x-tiled-addfb)
[734.704406] Starting subtest: x-tiled-addfb
[734.706452] Subtest x-tiled-addfb: SUCCESS (0.000s)
[734.803413] [117/133] (291s left) gem_userptr_blits (dmabuf-sync)
[734.871507] Starting subtest: dmabuf-sync
[734.875060] Subtest dmabuf-sync: SKIP (0.002s)
[735.025169] [118/133] (291s left) gem_userptr_blits (map-fixed-invalidate-overlap)
[735.096437] Starting subtest: map-fixed-invalidate-overlap
[735.100337] Subtest map-fixed-invalidate-overlap: SKIP (0.000s)
[735.218223] [119/133] (291s left) gem_exec_whisper (basic-contexts-all)
[735.279782] Starting subtest: basic-contexts-all
[746.332170] Subtest basic-contexts-all: SUCCESS (11.049s)
[746.518815] [120/133] (279s left) kms_content_protection (lic-type-0-hdcp14)
[746.658136] Starting subtest: lic-type-0-hdcp14
[746.662964] Subtest lic-type-0-hdcp14: SKIP (0.000s)
[746.769126] [121/133] (279s left) gem_huc_copy (huc-copy)
[746.824002] Starting subtest: huc-copy
[746.829029] Subtest huc-copy: SUCCESS (0.003s)
[746.939957] [122/133] (279s left) kms_cursor_edge_walk (128x128-top-bottom)
[747.042389] Starting subtest: 128x128-top-bottom
[747.044681] Starting dynamic subtest: pipe-A-eDP-1
[750.495031] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.453s)
[750.505892] Starting dynamic subtest: pipe-D-eDP-1
[753.627993] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.129s)
[753.630311] Subtest 128x128-top-bottom: SUCCESS (6.585s)
[754.441147] [123/133] (272s left) kms_prop_blob (blob-multiple)
[754.503160] Starting subtest: blob-multiple
[754.505687] Subtest blob-multiple: SUCCESS (0.002s)
[754.617975] [124/133] (271s left) syncobj_wait (invalid-multi-wait-unsubmitted-submitted)
[754.664046] Starting subtest: invalid-multi-wait-unsubmitted-submitted
[754.666490] Subtest invalid-multi-wait-unsubmitted-submitted: SUCCESS (0.000s)
[754.772968] [125/133] (271s left) gen9_exec_parse (basic-rejected-ctx-param)
[754.832682] Subtest basic-rejected-ctx-param: SKIP (0.000s)
[754.912695] [126/133] (271s left) gem_tiled_partial_pwrite_pread (writes)
[754.971316] Subtest writes: SKIP (0.000s)
[755.051803] [127/133] (271s left) kms_flip (2x-flip-vs-dpms-on-nop)
[755.146233] Starting subtest: 2x-flip-vs-dpms-on-nop
[755.155662] Subtest 2x-flip-vs-dpms-on-nop: SKIP (0.011s)
[755.237273] [128/133] (271s left) kms_pipe_crc_basic (nonblocking-crc)
[755.334891] Starting subtest: nonblocking-crc
[755.337160] Starting dynamic subtest: pipe-A-eDP-1
[756.105774] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.769s)
[756.117456] Starting dynamic subtest: pipe-B-eDP-1
[757.571359] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.466s)
[757.582801] Starting dynamic subtest: pipe-C-eDP-1
[758.918896] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.346s)
[758.930042] Starting dynamic subtest: pipe-D-eDP-1
[760.276506] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.354s)
[760.278433] Subtest nonblocking-crc: SUCCESS (4.942s)
[761.080012] [129/133] (265s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-mmap-wc)
[761.174479] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-mmap-wc
[767.746437] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-mmap-wc: SUCCESS (6.575s)
[767.861090] [130/133] (258s left) gem_pxp (protected-raw-src-copy-not-readible)
[767.999001] Starting subtest: protected-raw-src-copy-not-readible
[768.058152] Subtest protected-raw-src-copy-not-readible: SUCCESS (0.061s)
[768.167455] [131/133] (258s left) gem_exec_reloc (basic-wc-cpu-noreloc)
[768.237925] Subtest basic-wc-cpu-noreloc: SKIP (0.000s)
[768.318607] [132/133] (258s left) gem_eio (wait-10ms)
[768.554864] Starting subtest: wait-10ms
[768.939571] Subtest wait-10ms: SUCCESS (0.386s)
[769.078107] [133/133] (257s left) i915_pm_rpm (system-suspend-execbuf)
[770.603058] Starting subtest: system-suspend-execbuf
[828.245779] Subtest system-suspend-execbuf: SUCCESS (42.907s)
[828.620648] Closing watchdogs
results: parsing output: 0/ for test: syncobj_timeline
results: parsing output: 1/ for test: perf
results: parsing output: 2/ for test: gem_ctx_isolation
results: parsing output: 3/ for test: kms_async_flips
results: parsing output: 4/ for test: kms_plane_scaling
results: parsing output: 5/ for test: kms_chamelium_hpd
results: parsing output: 6/ for test: kms_pm_rpm
results: parsing output: 7/ for test: kms_flip_scaled_crc
results: parsing output: 8/ for test: kms_frontbuffer_tracking
results: parsing output: 9/ for test: kms_frontbuffer_tracking
results: parsing output: 10/ for test: gem_mmap_gtt
results: parsing output: 11/ for test: core_setmaster
results: parsing output: 12/ for test: syncobj_basic
results: parsing output: 13/ for test: kms_rotation_crc
results: parsing output: 14/ for test: syncobj_timeline
results: parsing output: 15/ for test: kms_frontbuffer_tracking
results: parsing output: 16/ for test: gem_linear_blits
results: parsing output: 17/ for test: kms_plane
results: parsing output: 18/ for test: kms_frontbuffer_tracking
results: parsing output: 19/ for test: kms_frontbuffer_tracking
results: parsing output: 20/ for test: i915_selftest
results: parsing output: 21/ for test: kms_frontbuffer_tracking
results: parsing output: 22/ for test: gem_pread
results: parsing output: 23/ for test: kms_frontbuffer_tracking
results: parsing output: 24/ for test: kms_frontbuffer_tracking
results: parsing output: 25/ for test: gem_exec_nop
results: parsing output: 26/ for test: kms_psr
results: parsing output: 27/ for test: syncobj_wait
results: parsing output: 28/ for test: kms_pm_dc
results: parsing output: 29/ for test: kms_psr
results: parsing output: 30/ for test: kms_cursor_crc
results: parsing output: 31/ for test: api_intel_allocator
results: parsing output: 32/ for test: kms_flip
results: parsing output: 33/ for test: gem_exec_balancer
results: parsing output: 34/ for test: kms_psr2_sf
results: parsing output: 35/ for test: api_intel_bb
results: parsing output: 36/ for test: gem_mmap_wc
results: parsing output: 37/ for test: gem_exec_suspend
results: parsing output: 38/ for test: kms_invalid_mode
results: parsing output: 39/ for test: sriov_basic
results: parsing output: 40/ for test: kms_big_fb
results: parsing output: 41/ for test: perf_pmu
results: parsing output: 42/ for test: kms_vblank
results: parsing output: 43/ for test: perf_pmu
results: parsing output: 44/ for test: gem_ctx_shared
results: parsing output: 45/ for test: kms_plane
results: parsing output: 46/ for test: i915_pciid
results: parsing output: 47/ for test: kms_plane_scaling
results: parsing output: 48/ for test: kms_frontbuffer_tracking
results: parsing output: 49/ for test: gem_exec_fence
results: parsing output: 50/ for test: kms_chamelium_color
results: parsing output: 51/ for test: gem_mmap_gtt
results: parsing output: 52/ for test: kms_cursor_crc
results: parsing output: 53/ for test: kms_ccs
results: parsing output: 54/ for test: gem_pwrite
results: parsing output: 55/ for test: kms_frontbuffer_tracking
results: parsing output: 56/ for test: kms_flip
results: parsing output: 57/ for test: kms_frontbuffer_tracking
results: parsing output: 58/ for test: fbdev
results: parsing output: 59/ for test: kms_ccs
results: parsing output: 60/ for test: gem_ppgtt
results: parsing output: 61/ for test: gem_exec_balancer
results: parsing output: 62/ for test: syncobj_timeline
results: parsing output: 63/ for test: gem_caching
results: parsing output: 64/ for test: kms_getfb
results: parsing output: 65/ for test: gem_exec_schedule
results: parsing output: 66/ for test: kms_ccs
results: parsing output: 67/ for test: kms_chamelium_frames
results: parsing output: 68/ for test: syncobj_timeline
results: parsing output: 69/ for test: kms_flip
results: parsing output: 70/ for test: gem_exec_schedule
results: parsing output: 71/ for test: kms_big_fb
results: parsing output: 72/ for test: kms_ccs
results: parsing output: 73/ for test: kms_flip_scaled_crc
results: parsing output: 74/ for test: kms_ccs
results: parsing output: 75/ for test: kms_big_fb
results: parsing output: 76/ for test: kms_flip
results: parsing output: 77/ for test: gem_spin_batch
results: parsing output: 78/ for test: kms_atomic_interruptible
results: parsing output: 79/ for test: i915_drm_fdinfo
results: parsing output: 80/ for test: vgem_basic
results: parsing output: 81/ for test: kms_frontbuffer_tracking
results: parsing output: 82/ for test: kms_feature_discovery
results: parsing output: 83/ for test: sw_sync
results: parsing output: 84/ for test: kms_cursor_crc
results: parsing output: 85/ for test: gem_mmap_gtt
results: parsing output: 86/ for test: gem_ctx_engines
results: parsing output: 87/ for test: gem_vm_create
results: parsing output: 88/ for test: kms_cursor_legacy
results: parsing output: 89/ for test: gem_exec_schedule
results: parsing output: 90/ for test: kms_color_pipeline
results: parsing output: 91/ for test: kms_lease
results: parsing output: 92/ for test: sw_sync
results: parsing output: 93/ for test: syncobj_eventfd
results: parsing output: 94/ for test: gem_reg_read
results: parsing output: 95/ for test: kms_panel_fitting
results: parsing output: 96/ for test: kms_psr
results: parsing output: 97/ for test: gem_ctx_persistence
results: parsing output: 98/ for test: kms_cursor_legacy
results: parsing output: 99/ for test: kms_cursor_legacy
results: parsing output: 100/ for test: kms_psr
results: parsing output: 101/ for test: kms_frontbuffer_tracking
results: parsing output: 102/ for test: kms_selftest
results: parsing output: 103/ for test: kms_frontbuffer_tracking
results: parsing output: 104/ for test: kms_psr
results: parsing output: 105/ for test: syncobj_wait
results: parsing output: 106/ for test: gem_render_copy
results: parsing output: 107/ for test: gem_eio
results: parsing output: 108/ for test: kms_big_fb
results: parsing output: 109/ for test: kms_frontbuffer_tracking
results: parsing output: 110/ for test: kms_atomic
results: parsing output: 111/ for test: perf
results: parsing output: 112/ for test: gem_fence_thrash
results: parsing output: 113/ for test: syncobj_wait
results: parsing output: 114/ for test: kms_big_fb
results: parsing output: 115/ for test: kms_big_fb
results: parsing output: 116/ for test: gem_userptr_blits
results: parsing output: 117/ for test: gem_userptr_blits
results: parsing output: 118/ for test: gem_exec_whisper
results: parsing output: 119/ for test: kms_content_protection
results: parsing output: 120/ for test: gem_huc_copy
results: parsing output: 121/ for test: kms_cursor_edge_walk
results: parsing output: 122/ for test: kms_prop_blob
results: parsing output: 123/ for test: syncobj_wait
results: parsing output: 124/ for test: gen9_exec_parse
results: parsing output: 125/ for test: gem_tiled_partial_pwrite_pread
results: parsing output: 126/ for test: kms_flip
results: parsing output: 127/ for test: kms_pipe_crc_basic
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_reloc
results: parsing output: 131/ for test: gem_eio
results: parsing output: 132/ for test: i915_pm_rpm
Done.