[57.813935] Initializing watchdogs
[57.813981]   /dev/watchdog0
[57.828119] [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]
[57.832585] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[57.835150] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[57.838410] [001/131] (960s left) kms_big_fb (4-tiled-32bpp-rotate-270)
[57.970178] Starting subtest: 4-tiled-32bpp-rotate-270
[58.005890] Subtest 4-tiled-32bpp-rotate-270: SKIP (0.033s)
[58.166494] [002/131] (960s left) kms_rotation_crc (multiplane-rotation)
[58.262236] Starting subtest: multiplane-rotation
[75.603104] Subtest multiplane-rotation: SUCCESS (17.349s)
[75.729104] [003/131] (942s left) perf (invalid-oa-metric-set-id)
[75.879223] Starting subtest: invalid-oa-metric-set-id
[75.888618] Subtest invalid-oa-metric-set-id: SUCCESS (0.010s)
[75.924413] [004/131] (942s left) syncobj_wait (wait-any-snapshot)
[75.980193] Starting subtest: wait-any-snapshot
[76.059955] Subtest wait-any-snapshot: SUCCESS (0.081s)
[76.156507] [005/131] (942s left) kms_psr (fbc-psr2-primary-blt)
[76.239952] Starting subtest: fbc-psr2-primary-blt
[76.241798] Starting dynamic subtest: eDP-1
[76.245194] Dynamic subtest eDP-1: SKIP (0.000s)
[76.248501] Subtest fbc-psr2-primary-blt: SKIP (0.001s)
[76.334427] [006/131] (942s left) kms_psr2_sf (psr2-overlay-plane-move-continuous-exceed-sf)
[81.343492] Starting subtest: psr2-overlay-plane-move-continuous-exceed-sf
[81.345471] Starting dynamic subtest: pipe-A-eDP-1
[93.360340] Dynamic subtest pipe-A-eDP-1: SUCCESS (12.017s)
[93.367396] Starting dynamic subtest: pipe-B-eDP-1
[105.379955] Dynamic subtest pipe-B-eDP-1: SUCCESS (12.021s)
[105.382703] Subtest psr2-overlay-plane-move-continuous-exceed-sf: SUCCESS (24.041s)
[106.258057] [007/131] (912s left) i915_pm_rc6_residency (media-rc6-accuracy)
[106.330406] Starting subtest: media-rc6-accuracy
[106.334931] Subtest media-rc6-accuracy: SKIP (0.000s)
[106.458527] [008/131] (912s left) core_getversion (basic)
[106.497821] Starting subtest: basic
[106.502546] Subtest basic: SUCCESS (0.000s)
[106.585899] [009/131] (912s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-onoff)
[106.698234] Starting subtest: psr-2p-primscrn-cur-indfb-onoff
[106.702174] Subtest psr-2p-primscrn-cur-indfb-onoff: SKIP (0.000s)
[106.833693] [010/131] (911s left) kms_debugfs (display-off-read-all)
[106.919779] Starting subtest: display-off-read-all
[107.206913] Subtest display-off-read-all: SUCCESS (0.288s)
[108.085428] [011/131] (910s left) syncobj_timeline (host-signal-points)
[108.143342] Starting subtest: host-signal-points
[108.145409] Subtest host-signal-points: SUCCESS (0.004s)
[108.257062] [012/131] (910s left) gem_exec_store (basic)
[108.314373] Starting subtest: basic
[108.439806] Subtest basic: SUCCESS (0.126s)
[108.644190] [013/131] (910s left) gem_exec_flush (basic-wb-rw-default)
[108.713185] Starting subtest: basic-wb-rw-default
[114.167978] Subtest basic-wb-rw-default: SUCCESS (5.457s)
[114.384300] [014/131] (904s left) vgem_basic (setversion)
[114.462637] Starting subtest: setversion
[114.467192] Subtest setversion: SUCCESS (0.000s)
[114.540936] [FACT vgem_basic (setversion)] new: kernel.kmod_is_loaded.vgem: true
[114.544194] [015/131] (904s left) syncobj_timeline (etime-multi-wait-all-available-unsubmitted-submitted)
[114.607392] Starting subtest: etime-multi-wait-all-available-unsubmitted-submitted
[114.713893] Subtest etime-multi-wait-all-available-unsubmitted-submitted: SUCCESS (0.106s)
[114.820148] [016/131] (904s left) kms_legacy_colorkey (basic)
[114.922655] Starting subtest: basic
[114.924892] Starting dynamic subtest: pipe-A
[114.966124] Dynamic subtest pipe-A: SUCCESS (0.045s)
[114.975832] Starting dynamic subtest: pipe-B
[114.978134] Dynamic subtest pipe-B: SUCCESS (0.001s)
[114.984653] Starting dynamic subtest: pipe-C
[114.986843] Dynamic subtest pipe-C: SUCCESS (0.000s)
[114.993267] Starting dynamic subtest: pipe-D
[114.995105] Dynamic subtest pipe-D: SUCCESS (0.000s)
[114.996947] Subtest basic: SUCCESS (0.049s)
[115.057315] [017/131] (903s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-onoff)
[115.154611] Starting subtest: fbc-1p-primscrn-cur-indfb-onoff
[119.065502] Subtest fbc-1p-primscrn-cur-indfb-onoff: SUCCESS (3.915s)
[120.297413] [018/131] (898s left) kms_rmfb (close-fd)
[120.402716] Starting subtest: close-fd
[120.405080] Starting dynamic subtest: pipe-A-eDP-1
[120.507987] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.106s)
[120.515851] Starting dynamic subtest: pipe-B-eDP-1
[121.721695] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.214s)
[121.728833] Starting dynamic subtest: pipe-C-eDP-1
[122.831905] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.108s)
[122.840223] Starting dynamic subtest: pipe-D-eDP-1
[123.978794] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.146s)
[123.980942] Subtest close-fd: SUCCESS (3.579s)
[125.196571] [019/131] (893s left) kms_atomic_interruptible (legacy-dpms)
[125.307888] Starting subtest: legacy-dpms
[125.310193] Starting dynamic subtest: pipe-A-eDP-1
[132.689103] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.380s)
[132.691390] Subtest legacy-dpms: SUCCESS (7.382s)
[133.551769] [020/131] (885s left) gem_ctx_persistence (legacy-engines-hostile)
[133.620068] Starting subtest: legacy-engines-hostile
[133.622296] Starting dynamic subtest: render
[133.795822] Dynamic subtest render: SUCCESS (0.175s)
[133.808807] Starting dynamic subtest: bsd1
[133.920613] Dynamic subtest bsd1: SUCCESS (0.123s)
[133.932110] Starting dynamic subtest: bsd2
[134.055046] Dynamic subtest bsd2: SUCCESS (0.131s)
[134.066302] Starting dynamic subtest: blt
[134.182993] Dynamic subtest blt: SUCCESS (0.126s)
[134.193728] Starting dynamic subtest: vebox
[134.265634] Dynamic subtest vebox: SUCCESS (0.081s)
[134.268208] Subtest legacy-engines-hostile: SUCCESS (0.646s)
[134.431342] [021/131] (884s left) gem_exec_whisper (basic-queues-forked-all)
[134.500060] Starting subtest: basic-queues-forked-all
[154.222661] Subtest basic-queues-forked-all: SUCCESS (19.715s)
[154.428175] [022/131] (864s left) kms_ccs (crc-primary-basic-4-tiled-mtl-rc-ccs-cc)
[154.539811] Starting subtest: crc-primary-basic-4-tiled-mtl-rc-ccs-cc
[154.542201] Starting dynamic subtest: pipe-A-eDP-1
[155.357536] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.811s)
[155.366069] Starting dynamic subtest: pipe-B-eDP-1
[156.911320] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.551s)
[156.920386] Starting dynamic subtest: pipe-C-eDP-1
[158.458068] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.545s)
[158.466856] Starting dynamic subtest: pipe-D-eDP-1
[159.988351] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.527s)
[159.990631] Subtest crc-primary-basic-4-tiled-mtl-rc-ccs-cc: SUCCESS (5.439s)
[161.195331] [023/131] (857s left) kms_content_protection (legacy-hdcp14)
[161.342401] Starting subtest: legacy-hdcp14
[161.347034] Subtest legacy-hdcp14: SKIP (0.000s)
[161.498540] [024/131] (857s left) kms_frontbuffer_tracking (fbc-tiling-y)
[161.606267] Starting subtest: fbc-tiling-y
[161.610457] Subtest fbc-tiling-y: SKIP (0.000s)
[161.740648] [025/131] (857s left) syncobj_wait (single-wait-for-submit-submitted)
[161.809755] Starting subtest: single-wait-for-submit-submitted
[161.913948] Subtest single-wait-for-submit-submitted: SUCCESS (0.102s)
[162.009285] [026/131] (857s left) kms_cursor_legacy (cursorb-vs-flipb-atomic)
[162.120869] Starting subtest: cursorB-vs-flipB-atomic
[162.125478] Subtest cursorB-vs-flipB-atomic: SKIP (0.001s)
[162.286764] [027/131] (857s left) kms_flip (2x-blocking-absolute-wf_vblank)
[162.376158] Starting subtest: 2x-blocking-absolute-wf_vblank
[162.384637] Subtest 2x-blocking-absolute-wf_vblank: SKIP (0.010s)
[162.486214] [028/131] (856s left) gem_mmap_offset (partial-unmap)
[162.548538] Starting subtest: partial-unmap
[162.550509] Starting dynamic subtest: smem0
[163.038088] Dynamic subtest smem0: SUCCESS (0.490s)
[163.040934] Subtest partial-unmap: SUCCESS (0.491s)
[163.195566] [029/131] (856s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-mmap-cpu)
[163.294674] Starting subtest: psr-1p-primscrn-pri-indfb-draw-mmap-cpu
[170.224921] Subtest psr-1p-primscrn-pri-indfb-draw-mmap-cpu: SUCCESS (6.931s)
[170.359327] [030/131] (849s left) kms_vblank (ts-continuation-idle-hang)
[170.475135] Starting subtest: ts-continuation-idle-hang
[170.477400] Starting dynamic subtest: pipe-A-eDP-1
[196.705872] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.226s)
[196.718981] Starting dynamic subtest: pipe-D-eDP-1
[221.643291] Dynamic subtest pipe-D-eDP-1: SUCCESS (24.935s)
[221.645903] Subtest ts-continuation-idle-hang: SUCCESS (51.166s)
[222.505910] [031/131] (796s left) gem_userptr_blits (readonly-unsync)
[222.575947] Subtest readonly-unsync: SKIP (0.000s)
[222.763219] [032/131] (796s left) gem_mmap (short-mmap)
[222.819664] Subtest short-mmap: SKIP (0.000s)
[222.877880] [033/131] (796s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-move)
[222.978457] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-move
[222.982731] Subtest fbcpsr-2p-scndscrn-cur-indfb-move: SKIP (0.000s)
[223.120374] [034/131] (796s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-onoff)
[223.215322] Starting subtest: psr-2p-scndscrn-spr-indfb-onoff
[223.219582] Subtest psr-2p-scndscrn-spr-indfb-onoff: SKIP (0.000s)
[223.334767] [035/131] (796s left) kms_chamelium_color (ctm-green-to-red)
[223.421697] Subtest ctm-green-to-red: SKIP (0.000s)
[223.469490] [036/131] (796s left) kms_frontbuffer_tracking (psr-suspend)
[223.566244] Starting subtest: psr-suspend
[262.518258] Subtest psr-suspend: SUCCESS (11.599s)
[262.668465] [037/131] (757s left) gem_spin_batch (engines)
[262.736816] Starting subtest: engines
[262.739244] Starting dynamic subtest: rcs0
[265.968477] Dynamic subtest rcs0: SUCCESS (3.242s)
[265.978663] Starting dynamic subtest: bcs0
[269.199090] Dynamic subtest bcs0: SUCCESS (3.238s)
[269.207764] Starting dynamic subtest: vcs0
[272.433013] Dynamic subtest vcs0: SUCCESS (3.240s)
[272.441782] Starting dynamic subtest: vcs1
[275.668047] Dynamic subtest vcs1: SUCCESS (3.236s)
[275.676261] Starting dynamic subtest: vecs0
[278.902198] Dynamic subtest vecs0: SUCCESS (3.236s)
[278.912330] Starting dynamic subtest: ccs0
[282.135972] Dynamic subtest ccs0: SUCCESS (3.234s)
[282.138283] Subtest engines: SUCCESS (19.442s)
[282.345962] [038/131] (737s left) kms_psr (fbc-pr-sprite-blt)
[282.451238] Starting subtest: fbc-pr-sprite-blt
[282.455209] Subtest fbc-pr-sprite-blt: SKIP (0.000s)
[282.545276] [039/131] (737s left) kms_psr (fbc-psr-primary-mmap-gtt)
[282.640933] Starting subtest: fbc-psr-primary-mmap-gtt
[282.643469] Starting dynamic subtest: eDP-1
[282.647512] Dynamic subtest eDP-1: SKIP (0.000s)
[282.651587] Subtest fbc-psr-primary-mmap-gtt: SKIP (0.001s)
[282.741010] [040/131] (737s left) gem_exec_schedule (preempt-hang)
[282.929668] Starting subtest: preempt-hang
[282.931727] Starting dynamic subtest: rcs0
[283.139015] Dynamic subtest rcs0: SUCCESS (0.214s)
[283.147541] Starting dynamic subtest: bcs0
[283.361612] Dynamic subtest bcs0: SUCCESS (0.222s)
[283.371922] Starting dynamic subtest: vcs0
[283.572933] Dynamic subtest vcs0: SUCCESS (0.208s)
[283.581214] Starting dynamic subtest: vcs1
[283.779908] Dynamic subtest vcs1: SUCCESS (0.207s)
[283.788535] Starting dynamic subtest: vecs0
[283.993150] Dynamic subtest vecs0: SUCCESS (0.212s)
[284.002954] Starting dynamic subtest: ccs0
[284.212506] Dynamic subtest ccs0: SUCCESS (0.219s)
[284.214672] Subtest preempt-hang: SUCCESS (1.287s)
[285.384468] [041/131] (734s left) gem_pxp (create-regular-context-1)
[285.508793] Starting subtest: create-regular-context-1
[285.511144] Subtest create-regular-context-1: SUCCESS (0.002s)
[285.652396] [042/131] (734s left) kms_big_fb (linear-32bpp-rotate-270)
[285.769462] Starting subtest: linear-32bpp-rotate-270
[285.788548] Subtest linear-32bpp-rotate-270: SKIP (0.019s)
[285.952006] [043/131] (734s left) kms_frontbuffer_tracking (fbc-shrfb-scaledprimary)
[286.062769] Starting subtest: fbc-shrfb-scaledprimary
[289.085730] Subtest fbc-shrfb-scaledprimary: SUCCESS (3.028s)
[290.279824] [044/131] (729s left) kms_getfb (getfb-reject-nv12)
[290.381031] Starting subtest: getfb-reject-nv12
[290.383334] Subtest getfb-reject-nv12: SUCCESS (0.001s)
[290.538910] [045/131] (729s left) gem_exec_parallel (contexts)
[290.613038] Starting subtest: contexts
[290.615391] Starting dynamic subtest: rcs0
[293.419712] Dynamic subtest rcs0: SUCCESS (2.805s)
[293.431324] Starting dynamic subtest: bcs0
[296.966998] Dynamic subtest bcs0: SUCCESS (3.542s)
[296.975882] Starting dynamic subtest: vcs0
[300.781724] Dynamic subtest vcs0: SUCCESS (3.814s)
[300.790150] Starting dynamic subtest: vcs1
[304.739871] Dynamic subtest vcs1: SUCCESS (3.957s)
[304.749348] Starting dynamic subtest: vecs0
[308.863416] Dynamic subtest vecs0: SUCCESS (4.121s)
[308.872669] Starting dynamic subtest: ccs0
[312.665898] Dynamic subtest ccs0: SUCCESS (3.801s)
[312.668427] Subtest contexts: SUCCESS (22.055s)
[312.891084] [046/131] (707s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-move)
[313.017627] Starting subtest: psr-2p-scndscrn-cur-indfb-move
[313.022094] Subtest psr-2p-scndscrn-cur-indfb-move: SKIP (0.000s)
[313.152416] [047/131] (706s left) prime_mmap_coherency (ioctl-errors)
[313.211040] Starting subtest: ioctl-errors
[328.955733] Subtest ioctl-errors: SUCCESS (15.749s)
[329.140666] [048/131] (691s left) kms_3d (basic)
[329.231521] Starting subtest: basic
[331.226615] Subtest basic: SUCCESS (1.998s)
[331.729776] [049/131] (688s left) gem_ctx_param (set-priority-not-supported)
[331.790945] Starting subtest: set-priority-not-supported
[331.795741] Subtest set-priority-not-supported: SKIP (0.000s)
[331.893378] [050/131] (688s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-64bpp-ytile-upscaling)
[332.010549] Starting subtest: flip-32bpp-ytile-to-64bpp-ytile-upscaling
[332.012803] Starting dynamic subtest: pipe-A-default-mode
[332.299842] Dynamic subtest pipe-A-default-mode: SKIP (0.285s)
[332.304519] Subtest flip-32bpp-ytile-to-64bpp-ytile-upscaling: SKIP (0.286s)
[333.186825] [051/131] (687s left) kms_ccs (missing-ccs-buffer-4-tiled-mtl-rc-ccs)
[333.287503] Starting subtest: missing-ccs-buffer-4-tiled-mtl-rc-ccs
[333.289963] Starting dynamic subtest: pipe-A-eDP-1
[333.311056] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s)
[333.322982] Starting dynamic subtest: pipe-B-eDP-1
[333.342580] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[333.351781] Starting dynamic subtest: pipe-C-eDP-1
[333.371115] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[333.380228] Starting dynamic subtest: pipe-D-eDP-1
[333.400300] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[333.402475] Subtest missing-ccs-buffer-4-tiled-mtl-rc-ccs: SUCCESS (0.005s)
[335.586740] [052/131] (684s left) kms_psr2_sf (pr-cursor-plane-move-continuous-exceed-fully-sf)
[340.636734] Starting subtest: pr-cursor-plane-move-continuous-exceed-fully-sf
[340.641197] Subtest pr-cursor-plane-move-continuous-exceed-fully-sf: SKIP (0.002s)
[341.490450] [053/131] (678s left) kms_psr (psr-sprite-mmap-cpu)
[341.598251] Starting subtest: psr-sprite-mmap-cpu
[341.600516] Starting dynamic subtest: eDP-1
[343.354879] Dynamic subtest eDP-1: SUCCESS (1.759s)
[343.357147] Subtest psr-sprite-mmap-cpu: SUCCESS (1.760s)
[344.182623] [054/131] (676s left) syncobj_wait (single-wait-signaled)
[344.267788] Starting subtest: single-wait-signaled
[344.270266] Subtest single-wait-signaled: SUCCESS (0.000s)
[344.396621] [055/131] (676s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-shrfb-draw-mmap-gtt)
[344.499439] Starting subtest: fbc-1p-offscreen-pri-shrfb-draw-mmap-gtt
[344.503918] Subtest fbc-1p-offscreen-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[344.641466] [056/131] (675s left) kms_ccs (bad-aux-stride-yf-tiled-ccs)
[344.741226] Starting subtest: bad-aux-stride-yf-tiled-ccs
[344.743511] Starting dynamic subtest: pipe-A-eDP-1
[344.766666] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[344.778384] Starting dynamic subtest: pipe-B-eDP-1
[344.799776] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[344.808393] Starting dynamic subtest: pipe-C-eDP-1
[344.830044] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[344.838251] Starting dynamic subtest: pipe-D-eDP-1
[344.859158] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[344.863279] Subtest bad-aux-stride-yf-tiled-ccs: SKIP (0.004s)
[346.984168] [057/131] (673s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-0-async-flip)
[347.090154] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-0-async-flip
[347.094759] Subtest yf-tiled-max-hw-stride-64bpp-rotate-0-async-flip: SKIP (0.000s)
[347.229167] [058/131] (673s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-wc)
[347.339742] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-wc
[347.344490] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[347.450468] [059/131] (673s left) gem_pxp (verify-pxp-stale-buf-optout-execution)
[347.510573] Starting subtest: verify-pxp-stale-buf-optout-execution
[348.573517] Subtest verify-pxp-stale-buf-optout-execution: SUCCESS (1.060s)
[348.730207] [060/131] (671s left) kms_plane (plane-position-hole-dpms)
[348.830177] Starting subtest: plane-position-hole-dpms
[349.336256] Starting dynamic subtest: pipe-A-plane-1
[351.783434] Dynamic subtest pipe-A-plane-1: SUCCESS (2.449s)
[351.793522] Starting dynamic subtest: pipe-A-plane-2
[354.183448] Dynamic subtest pipe-A-plane-2: SUCCESS (2.397s)
[354.195163] Starting dynamic subtest: pipe-A-plane-3
[356.602313] Dynamic subtest pipe-A-plane-3: SUCCESS (2.419s)
[356.612716] Starting dynamic subtest: pipe-A-plane-4
[358.985065] Dynamic subtest pipe-A-plane-4: SUCCESS (2.382s)
[358.994902] Starting dynamic subtest: pipe-A-plane-5
[359.009390] Dynamic subtest pipe-A-plane-5: SUCCESS (0.024s)
[360.216382] Starting dynamic subtest: pipe-B-plane-1
[362.585237] Dynamic subtest pipe-B-plane-1: SUCCESS (2.373s)
[362.595105] Starting dynamic subtest: pipe-B-plane-2
[364.971444] Dynamic subtest pipe-B-plane-2: SUCCESS (2.384s)
[364.981935] Starting dynamic subtest: pipe-B-plane-3
[367.260616] Dynamic subtest pipe-B-plane-3: SUCCESS (2.290s)
[367.270979] Starting dynamic subtest: pipe-B-plane-4
[369.564697] Dynamic subtest pipe-B-plane-4: SUCCESS (2.302s)
[369.575142] Starting dynamic subtest: pipe-B-plane-5
[369.591273] Dynamic subtest pipe-B-plane-5: SUCCESS (0.024s)
[369.593453] Subtest plane-position-hole-dpms: SUCCESS (20.759s)
[370.383318] [061/131] (650s left) perf (gen12-mi-rpc)
[370.510965] Starting subtest: gen12-mi-rpc
[370.513942] Starting dynamic subtest: rcs0
[370.529736] Dynamic subtest rcs0: SUCCESS (0.016s)
[370.531705] Subtest gen12-mi-rpc: SUCCESS (0.017s)
[370.610303] [062/131] (650s left) gem_ctx_param (invalid-param-set)
[370.710712] Starting subtest: invalid-param-set
[370.713149] Subtest invalid-param-set: SUCCESS (0.000s)
[370.815634] [063/131] (650s left) gem_ctx_shared (q-independent)
[370.879385] Starting subtest: Q-independent
[370.881725] Starting dynamic subtest: rcs0
[370.945434] Dynamic subtest rcs0: SUCCESS (0.065s)
[370.958368] Starting dynamic subtest: vcs0
[370.993707] Dynamic subtest vcs0: SUCCESS (0.048s)
[371.005653] Starting dynamic subtest: vcs1
[371.031462] Dynamic subtest vcs1: SUCCESS (0.037s)
[371.041634] Starting dynamic subtest: vecs0
[371.075869] Dynamic subtest vecs0: SUCCESS (0.044s)
[371.087412] Starting dynamic subtest: ccs0
[371.119778] Dynamic subtest ccs0: SUCCESS (0.043s)
[371.122085] Subtest Q-independent: SUCCESS (0.240s)
[372.403136] [064/131] (648s left) kms_ccs (crc-primary-rotation-180-4-tiled-mtl-mc-ccs)
[372.501368] Starting subtest: crc-primary-rotation-180-4-tiled-mtl-mc-ccs
[372.503600] Starting dynamic subtest: pipe-A-eDP-1
[374.630496] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.128s)
[374.639635] Starting dynamic subtest: pipe-B-eDP-1
[376.682498] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.050s)
[376.691641] Starting dynamic subtest: pipe-C-eDP-1
[378.739265] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.056s)
[378.749062] Starting dynamic subtest: pipe-D-eDP-1
[380.758330] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.017s)
[380.760427] Subtest crc-primary-rotation-180-4-tiled-mtl-mc-ccs: SUCCESS (8.257s)
[381.997113] [065/131] (638s left) kms_lease (atomic-implicit-crtc)
[382.097762] Starting subtest: atomic-implicit-crtc
[382.099947] Starting dynamic subtest: pipe-A-eDP-1
[382.111884] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[382.123368] Starting dynamic subtest: pipe-B-eDP-1
[382.134197] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.009s)
[382.143338] Starting dynamic subtest: pipe-C-eDP-1
[382.153159] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.009s)
[382.162017] Starting dynamic subtest: pipe-D-eDP-1
[382.172402] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.009s)
[382.174283] Subtest atomic-implicit-crtc: SUCCESS (0.033s)
[382.262123] [066/131] (638s left) gem_exec_reloc (basic-wc)
[382.323534] Subtest basic-wc: SKIP (0.000s)
[382.399838] [067/131] (638s left) syncobj_timeline (transfer-timeline-point)
[382.461282] Starting subtest: transfer-timeline-point
[382.463139] Subtest transfer-timeline-point: SUCCESS (0.000s)
[382.594753] [068/131] (638s left) api_intel_bb (reset-flags)
[382.659640] Starting subtest: reset-flags
[382.664776] Subtest reset-flags: SUCCESS (0.007s)
[382.813208] [069/131] (638s left) kms_flip_scaled_crc (flip-32bpp-linear-to-64bpp-linear-upscaling)
[382.914198] Starting subtest: flip-32bpp-linear-to-64bpp-linear-upscaling
[382.916068] Starting dynamic subtest: pipe-A-default-mode
[385.650071] Dynamic subtest pipe-A-default-mode: SUCCESS (2.734s)
[385.652497] Subtest flip-32bpp-linear-to-64bpp-linear-upscaling: SUCCESS (2.735s)
[386.492761] [070/131] (634s left) kms_ccs (bad-rotation-90-4-tiled-mtl-rc-ccs)
[386.584853] Starting subtest: bad-rotation-90-4-tiled-mtl-rc-ccs
[386.587109] Starting dynamic subtest: pipe-A-eDP-1
[386.721971] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.129s)
[386.733916] Starting dynamic subtest: pipe-B-eDP-1
[386.754014] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[386.762898] Starting dynamic subtest: pipe-C-eDP-1
[386.782322] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.002s)
[386.790823] Starting dynamic subtest: pipe-D-eDP-1
[386.809850] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.002s)
[386.811766] Subtest bad-rotation-90-4-tiled-mtl-rc-ccs: SUCCESS (0.139s)
[388.984568] [071/131] (632s left) sw_sync (sync_merge_invalid)
[389.024675] Starting subtest: sync_merge_invalid
[389.049631] Subtest sync_merge_invalid: SUCCESS (0.024s)
[389.135016] [072/131] (632s left) kms_big_fb (yf-tiled-32bpp-rotate-180)
[389.226034] Starting subtest: yf-tiled-32bpp-rotate-180
[389.230673] Subtest yf-tiled-32bpp-rotate-180: SKIP (0.000s)
[389.357504] [073/131] (631s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-mmap-cpu)
[389.462028] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-mmap-cpu
[396.375305] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-mmap-cpu: SUCCESS (6.914s)
[396.522651] [074/131] (624s left) gem_userptr_blits (sd-probe)
[396.584954] Starting subtest: sd-probe
[396.586959] Subtest sd-probe: SUCCESS (0.000s)
[396.753938] [075/131] (624s left) gem_fenced_exec_thrash (no-spare-fences-busy)
[396.816258] Subtest no-spare-fences-busy: SKIP (0.000s)
[396.903995] [076/131] (624s left) kms_plane_cursor (viewport)
[397.000975] Starting subtest: viewport
[397.005371] Starting dynamic subtest: pipe-A-eDP-1-size-64
[399.500952] Dynamic subtest pipe-A-eDP-1-size-64: SUCCESS (2.499s)
[399.560621] Starting dynamic subtest: pipe-A-eDP-1-size-128
[401.979000] Dynamic subtest pipe-A-eDP-1-size-128: SUCCESS (2.426s)
[402.040033] Starting dynamic subtest: pipe-A-eDP-1-size-256
[404.436467] Dynamic subtest pipe-A-eDP-1-size-256: SUCCESS (2.406s)
[404.797304] Starting dynamic subtest: pipe-B-eDP-1-size-64
[407.964794] Dynamic subtest pipe-B-eDP-1-size-64: SUCCESS (3.180s)
[408.025477] Starting dynamic subtest: pipe-B-eDP-1-size-128
[410.443522] Dynamic subtest pipe-B-eDP-1-size-128: SUCCESS (2.426s)
[410.504521] Starting dynamic subtest: pipe-B-eDP-1-size-256
[412.942915] Dynamic subtest pipe-B-eDP-1-size-256: SUCCESS (2.448s)
[413.291739] Starting dynamic subtest: pipe-C-eDP-1-size-64
[416.090857] Dynamic subtest pipe-C-eDP-1-size-64: SUCCESS (2.810s)
[416.128568] Starting dynamic subtest: pipe-C-eDP-1-size-128
[418.145901] Dynamic subtest pipe-C-eDP-1-size-128: SUCCESS (2.024s)
[418.184126] Starting dynamic subtest: pipe-C-eDP-1-size-256
[420.322641] Dynamic subtest pipe-C-eDP-1-size-256: SUCCESS (2.145s)
[420.652641] Starting dynamic subtest: pipe-D-eDP-1-size-64
[423.393904] Dynamic subtest pipe-D-eDP-1-size-64: SUCCESS (2.750s)
[423.434887] Starting dynamic subtest: pipe-D-eDP-1-size-128
[425.447278] Dynamic subtest pipe-D-eDP-1-size-128: SUCCESS (2.024s)
[425.486175] Starting dynamic subtest: pipe-D-eDP-1-size-256
[427.537111] Dynamic subtest pipe-D-eDP-1-size-256: SUCCESS (2.057s)
[427.856753] Subtest viewport: SUCCESS (30.857s)
[428.675474] [077/131] (592s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-mmap-gtt)
[428.786301] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-mmap-gtt
[428.790811] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[428.928246] [078/131] (592s left) syncobj_timeline (multi-wait-available-signaled)
[428.999792] Starting subtest: multi-wait-available-signaled
[429.002124] Subtest multi-wait-available-signaled: SUCCESS (0.000s)
[429.146254] [079/131] (592s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-blt)
[429.248450] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-blt
[429.252844] Subtest fbc-2p-scndscrn-cur-indfb-draw-blt: SKIP (0.000s)
[429.393201] [080/131] (592s left) gem_exec_reloc (basic-gtt-cpu-noreloc)
[429.468312] Subtest basic-gtt-cpu-noreloc: SKIP (0.000s)
[429.560733] [081/131] (592s left) gem_exec_reloc (basic-cpu-noreloc)
[429.619064] Subtest basic-cpu-noreloc: SKIP (0.000s)
[429.709468] [082/131] (591s left) kms_vblank (crtc-id)
[429.799597] Starting subtest: crtc-id
[429.801568] Starting dynamic subtest: pipe-A-eDP-1
[430.245723] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.446s)
[430.259316] Starting dynamic subtest: pipe-D-eDP-1
[431.339471] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.091s)
[431.341916] Subtest crtc-id: SUCCESS (1.541s)
[432.169938] [083/131] (589s left) gem_exec_balancer (parallel-bb-first)
[432.427024] Starting subtest: parallel-bb-first
[433.316469] Subtest parallel-bb-first: SUCCESS (0.889s)
[434.399544] [084/131] (587s left) syncobj_timeline (device-submit-unordered)
[434.468405] Starting subtest: device-submit-unordered
[434.470696] Subtest device-submit-unordered: SUCCESS (0.000s)
[434.601103] [085/131] (587s left) gem_exec_parallel (userptr)
[434.675858] Starting subtest: userptr
[434.679284] Starting dynamic subtest: rcs0
[436.232149] Dynamic subtest rcs0: SUCCESS (1.557s)
[436.242058] Starting dynamic subtest: bcs0
[437.743492] Dynamic subtest bcs0: SUCCESS (1.510s)
[437.758715] Starting dynamic subtest: vcs0
[439.281309] Dynamic subtest vcs0: SUCCESS (1.534s)
[439.293472] Starting dynamic subtest: vcs1
[441.208690] Dynamic subtest vcs1: SUCCESS (1.925s)
[441.218652] Starting dynamic subtest: vecs0
[443.257477] Dynamic subtest vecs0: SUCCESS (2.047s)
[443.270061] Starting dynamic subtest: ccs0
[444.787806] Dynamic subtest ccs0: SUCCESS (1.529s)
[444.790664] Subtest userptr: SUCCESS (10.115s)
[445.000475] [086/131] (576s left) api_intel_allocator (reopen)
[445.061523] Starting subtest: reopen
[445.067625] Subtest reopen: SUCCESS (0.007s)
[445.238894] [087/131] (576s left) kms_color_pipeline (plane-lut1d-lut1d)
[445.347069] Starting subtest: plane-lut1d-lut1d
[445.360635] Starting dynamic subtest: pipe-A-eDP-1
[446.071840] Dynamic subtest pipe-A-eDP-1: FAIL (0.343s)
[446.801290] Starting dynamic subtest: pipe-B-eDP-1
[447.619427] Dynamic subtest pipe-B-eDP-1: FAIL (0.301s)
[448.191288] Starting dynamic subtest: pipe-C-eDP-1
[449.033142] Dynamic subtest pipe-C-eDP-1: FAIL (0.246s)
[449.486974] Starting dynamic subtest: pipe-D-eDP-1
[450.303702] Dynamic subtest pipe-D-eDP-1: FAIL (0.235s)
[450.305706] Subtest plane-lut1d-lut1d: FAIL (4.658s)
[450.863510] [088/131] (571s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-mmap-wc)
[450.963181] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-mmap-wc
[455.161355] Subtest fbc-1p-primscrn-pri-indfb-draw-mmap-wc: SUCCESS (4.204s)
[456.374945] [089/131] (565s left) kms_flip (flip-vs-absolute-wf_vblank)
[456.465057] Starting subtest: flip-vs-absolute-wf_vblank
[456.467399] Starting dynamic subtest: A-eDP1
[465.353251] Dynamic subtest A-eDP1: SUCCESS (8.890s)
[465.363356] Starting dynamic subtest: B-eDP1
[474.250348] Dynamic subtest B-eDP1: SUCCESS (8.898s)
[474.264056] Starting dynamic subtest: C-eDP1
[483.132032] Dynamic subtest C-eDP1: SUCCESS (8.882s)
[483.142139] Starting dynamic subtest: D-eDP1
[492.037206] Dynamic subtest D-eDP1: SUCCESS (8.902s)
[492.039656] Subtest flip-vs-absolute-wf_vblank: SUCCESS (35.583s)
[493.251659] [090/131] (528s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-blt)
[493.365487] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-blt
[493.370050] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-blt: SKIP (0.000s)
[493.492548] [091/131] (528s left) i915_suspend (basic-s2idle-without-i915)
[493.530112] Starting subtest: basic-s2idle-without-i915
[515.787188] Subtest basic-s2idle-without-i915: SUCCESS (7.275s)
[515.899941] [092/131] (506s left) kms_pm_rpm (basic-rte)
[515.958223] Starting subtest: basic-rte
[518.931538] Subtest basic-rte: SUCCESS (2.984s)
[520.952055] [093/131] (501s left) i915_pm_freq_api (freq-reset)
[521.023597] Starting subtest: freq-reset
[521.026939] Starting dynamic subtest: gt0
[521.168780] Dynamic subtest gt0: SUCCESS (0.146s)
[521.179680] Starting dynamic subtest: gt1
[521.296397] Dynamic subtest gt1: SUCCESS (0.129s)
[521.299418] Subtest freq-reset: SUCCESS (0.277s)
[521.395089] [094/131] (500s left) i915_drm_fdinfo (all-busy-idle-check-all)
[521.445511] Starting subtest: all-busy-idle-check-all
[521.451224] Subtest all-busy-idle-check-all: SKIP (0.004s)
[521.547916] [095/131] (500s left) gem_exec_reloc (basic-cpu-wc-noreloc)
[521.642565] Subtest basic-cpu-wc-noreloc: SKIP (0.000s)
[521.733092] [096/131] (500s left) gen9_exec_parse (basic-rejected-ctx-param)
[521.793543] Subtest basic-rejected-ctx-param: SKIP (0.000s)
[521.871492] [097/131] (500s left) kms_plane_scaling (planes-upscale-factor-0-25-downscale-factor-0-5)
[521.969327] Starting subtest: planes-upscale-factor-0-25-downscale-factor-0-5
[521.971854] Starting dynamic subtest: pipe-A
[521.989503] Dynamic subtest pipe-A: SKIP (0.016s)
[522.004529] Starting dynamic subtest: pipe-B
[522.024269] Dynamic subtest pipe-B: SKIP (0.032s)
[522.035475] Starting dynamic subtest: pipe-C
[522.055575] Dynamic subtest pipe-C: SKIP (0.032s)
[522.064326] Starting dynamic subtest: pipe-D
[522.085249] Dynamic subtest pipe-D: SKIP (0.031s)
[522.090461] Subtest planes-upscale-factor-0-25-downscale-factor-0-5: SKIP (0.113s)
[522.213330] [098/131] (500s left) gem_ctx_isolation (preservation)
[522.278664] Starting subtest: preservation
[522.281502] Starting dynamic subtest: rcs0
[522.433275] Dynamic subtest rcs0: SUCCESS (0.154s)
[522.445442] Starting dynamic subtest: bcs0
[522.603406] Dynamic subtest bcs0: SUCCESS (0.169s)
[522.615274] Starting dynamic subtest: vcs0
[522.746635] Dynamic subtest vcs0: SUCCESS (0.143s)
[522.755807] Starting dynamic subtest: vcs1
[524.437314] Dynamic subtest vcs1: SUCCESS (1.693s)
[524.453919] Starting dynamic subtest: vecs0
[526.411314] Dynamic subtest vecs0: SUCCESS (1.976s)
[526.420749] Starting dynamic subtest: ccs0
[528.395035] Dynamic subtest ccs0: SUCCESS (1.986s)
[528.397724] Subtest preservation: SUCCESS (6.128s)
[528.655432] [099/131] (493s left) kms_feature_discovery (display-2x)
[528.768546] Starting subtest: display-2x
[528.773740] Subtest display-2x: SKIP (0.000s)
[528.862823] [100/131] (493s left) perf_pmu (event-wait)
[528.908657] Starting subtest: event-wait
[528.911510] Starting dynamic subtest: rcs0
[528.917212] Dynamic subtest rcs0: SKIP (0.000s)
[528.922503] Subtest event-wait: SKIP (0.001s)
[529.046304] [101/131] (493s left) gem_ctx_engines (execute-oneforall)
[529.112733] Starting subtest: execute-oneforall
[529.595749] Subtest execute-oneforall: SUCCESS (0.483s)
[531.419301] [102/131] (491s left) kms_big_fb (y-tiled-64bpp-rotate-0)
[531.526528] Starting subtest: y-tiled-64bpp-rotate-0
[531.531441] Subtest y-tiled-64bpp-rotate-0: SKIP (0.000s)
[531.660059] [103/131] (490s left) gem_set_tiling_vs_blt (untiled-to-tiled)
[531.732582] Subtest untiled-to-tiled: SKIP (0.000s)
[531.815212] [104/131] (490s left) kms_chamelium_edid (dp-edid-stress-resolution-non-4k)
[532.207508] Subtest dp-edid-stress-resolution-non-4k: SKIP (0.000s)
[533.011447] [105/131] (489s left) gem_mmap (big-bo)
[533.077782] Subtest big-bo: SKIP (0.000s)
[533.147373] [106/131] (489s left) gem_exec_fence (syncobj-signal)
[533.580140] Starting subtest: syncobj-signal
[533.586504] Subtest syncobj-signal: SUCCESS (0.005s)
[535.382205] [107/131] (487s left) kms_cursor_edge_walk (128x128-left-edge)
[535.489595] Starting subtest: 128x128-left-edge
[535.492353] Starting dynamic subtest: pipe-A-eDP-1
[538.990061] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.503s)
[539.000351] Starting dynamic subtest: pipe-D-eDP-1
[542.106428] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.116s)
[542.109309] Subtest 128x128-left-edge: SUCCESS (6.622s)
[542.931065] [108/131] (479s left) syncobj_wait (single-wait-submitted)
[542.999211] Starting subtest: single-wait-submitted
[543.102914] Subtest single-wait-submitted: SUCCESS (0.104s)
[543.202897] [109/131] (479s left) kms_atomic (plane-invalid-params-fence)
[543.303561] Starting subtest: plane-invalid-params-fence
[543.306505] Starting dynamic subtest: pipe-A-eDP-1
[543.662366] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.359s)
[543.664977] Subtest plane-invalid-params-fence: SUCCESS (0.361s)
[544.583518] [110/131] (478s left) gem_exec_await (wide-contexts)
[544.763110] Starting subtest: wide-contexts
[568.129909] Subtest wide-contexts: SUCCESS (23.365s)
[568.355341] [111/131] (454s left) kms_prop_blob (invalid-get-prop)
[568.439774] Starting subtest: invalid-get-prop
[568.442264] Subtest invalid-get-prop: SUCCESS (0.000s)
[568.576966] [112/131] (454s left) kms_psr (psr2-primary-page-flip)
[568.690722] Starting subtest: psr2-primary-page-flip
[568.693105] Starting dynamic subtest: eDP-1
[570.438468] Dynamic subtest eDP-1: SUCCESS (1.746s)
[570.441384] Subtest psr2-primary-page-flip: SUCCESS (1.747s)
[571.320984] [113/131] (451s left) gem_userptr_blits (invalid-null-pointer)
[571.389376] Starting subtest: invalid-null-pointer
[571.391730] Subtest invalid-null-pointer: SUCCESS (0.001s)
[571.543103] [114/131] (451s left) syncobj_timeline (reset-multiple-signaled)
[571.608321] Starting subtest: reset-multiple-signaled
[571.611010] Subtest reset-multiple-signaled: SUCCESS (0.000s)
[571.747223] [115/131] (451s left) gem_exec_async (forked-writes)
[571.816256] Starting subtest: forked-writes
[571.818794] Starting dynamic subtest: rcs0
[571.846524] Dynamic subtest rcs0: SUCCESS (0.031s)
[571.856331] Starting dynamic subtest: bcs0
[571.871298] Dynamic subtest bcs0: SUCCESS (0.024s)
[571.880523] Starting dynamic subtest: vcs0
[571.893468] Dynamic subtest vcs0: SUCCESS (0.021s)
[571.902763] Starting dynamic subtest: vcs1
[571.916297] Dynamic subtest vcs1: SUCCESS (0.022s)
[571.927353] Starting dynamic subtest: vecs0
[571.940225] Dynamic subtest vecs0: SUCCESS (0.023s)
[571.950163] Starting dynamic subtest: ccs0
[571.959725] Dynamic subtest ccs0: SUCCESS (0.019s)
[571.962758] Subtest forked-writes: SUCCESS (0.145s)
[572.228200] [116/131] (450s left) kms_plane_scaling (planes-downscale-factor-0-75)
[572.313756] Starting subtest: planes-downscale-factor-0-75
[572.316152] Starting dynamic subtest: pipe-A
[572.334033] Dynamic subtest pipe-A: SKIP (0.017s)
[572.343517] Starting dynamic subtest: pipe-B
[572.368358] Dynamic subtest pipe-B: SKIP (0.033s)
[572.377594] Starting dynamic subtest: pipe-C
[572.399884] Dynamic subtest pipe-C: SKIP (0.032s)
[572.408982] Starting dynamic subtest: pipe-D
[572.429902] Dynamic subtest pipe-D: SKIP (0.029s)
[572.434265] Subtest planes-downscale-factor-0-75: SKIP (0.113s)
[572.570015] [117/131] (450s left) gem_mmap_gtt (cpuset-basic-small-copy-xy)
[572.633305] Subtest cpuset-basic-small-copy-XY: SKIP (0.000s)
[572.701900] [118/131] (450s left) dumb_buffer (map-uaf)
[572.748179] Starting subtest: map-uaf
[572.750170] Subtest map-uaf: SUCCESS (0.004s)
[572.884789] [119/131] (450s left) kms_fbcon_fbt (fbc-suspend)
[572.943421] Starting subtest: fbc-suspend
[622.085902] Subtest fbc-suspend: SUCCESS (19.016s)
[623.461621] [120/131] (399s left) perf (blocking)
[623.628019] Starting subtest: blocking
[623.630333] Starting dynamic subtest: 0-rcs0
[633.655730] Dynamic subtest 0-rcs0: SUCCESS (10.046s)
[633.666473] Starting dynamic subtest: 1-vcs1
[643.698743] Dynamic subtest 1-vcs1: SUCCESS (10.049s)
[643.701742] Subtest blocking: SUCCESS (20.099s)
[643.789639] [121/131] (379s left) kms_cursor_crc (cursor-onscreen-128x128)
[644.022758] Starting subtest: cursor-onscreen-128x128
[644.025049] Starting dynamic subtest: pipe-A-eDP-1
[646.141311] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.117s)
[646.170591] Starting dynamic subtest: pipe-D-eDP-1
[648.906734] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.744s)
[648.908935] Subtest cursor-onscreen-128x128: SUCCESS (4.888s)
[649.730049] [122/131] (373s left) kms_cursor_crc (cursor-rapid-movement-512x170)
[650.016449] Starting subtest: cursor-rapid-movement-512x170
[650.020853] Subtest cursor-rapid-movement-512x170: SKIP (0.002s)
[650.209313] [123/131] (373s left) kms_cursor_legacy (short-flip-before-cursor-atomic-transitions-varying-size)
[650.355711] Starting subtest: short-flip-before-cursor-atomic-transitions-varying-size
[651.302404] Subtest short-flip-before-cursor-atomic-transitions-varying-size: SUCCESS (0.947s)
[652.160366] [124/131] (371s left) gem_exec_schedule (preempt-self)
[652.235077] Starting subtest: preempt-self
[652.236999] Starting dynamic subtest: rcs0
[652.255783] Dynamic subtest rcs0: SUCCESS (0.029s)
[652.266892] Starting dynamic subtest: bcs0
[652.274241] Dynamic subtest bcs0: SUCCESS (0.017s)
[652.283600] Starting dynamic subtest: vcs0
[652.291773] Dynamic subtest vcs0: SUCCESS (0.017s)
[652.301276] Starting dynamic subtest: vcs1
[652.312972] Dynamic subtest vcs1: SUCCESS (0.021s)
[652.323852] Starting dynamic subtest: vecs0
[652.334530] Dynamic subtest vecs0: SUCCESS (0.021s)
[652.343579] Starting dynamic subtest: ccs0
[652.354610] Dynamic subtest ccs0: SUCCESS (0.019s)
[652.356812] Subtest preempt-self: SUCCESS (0.129s)
[653.577252] [125/131] (369s left) kms_big_fb (x-tiled-64bpp-rotate-180)
[653.687584] Starting subtest: x-tiled-64bpp-rotate-180
[655.188214] Subtest x-tiled-64bpp-rotate-180: SUCCESS (1.500s)
[655.403386] [126/131] (368s left) kms_flip (2x-flip-vs-modeset)
[655.503046] Starting subtest: 2x-flip-vs-modeset
[655.512546] Subtest 2x-flip-vs-modeset: SKIP (0.010s)
[655.615214] [127/131] (367s left) perf_pmu (most-busy-check-all)
[655.663510] Starting subtest: most-busy-check-all
[655.665521] Starting dynamic subtest: rcs0
[657.464227] Dynamic subtest rcs0: SUCCESS (1.800s)
[657.477282] Starting dynamic subtest: bcs0
[659.449148] Dynamic subtest bcs0: SUCCESS (1.982s)
[659.462681] Starting dynamic subtest: vcs0
[661.431514] Dynamic subtest vcs0: SUCCESS (1.979s)
[661.444740] Starting dynamic subtest: vcs1
[663.480378] Dynamic subtest vcs1: SUCCESS (2.046s)
[663.493610] Starting dynamic subtest: vecs0
[665.463373] Dynamic subtest vecs0: SUCCESS (1.980s)
[665.475770] Starting dynamic subtest: ccs0
[667.448457] Dynamic subtest ccs0: SUCCESS (1.982s)
[667.451616] Subtest most-busy-check-all: SUCCESS (11.787s)
[667.587017] [128/131] (356s left) kms_chamelium_hpd (vga-hpd-with-enabled-mode)
[667.986488] Subtest vga-hpd-with-enabled-mode: SKIP (0.000s)
[668.839916] [129/131] (354s left) gem_render_copy (yf-tiled-mc-ccs-to-vebox-yf-tiled)
[668.899984] Starting subtest: yf-tiled-mc-ccs-to-vebox-yf-tiled
[668.904492] Subtest yf-tiled-mc-ccs-to-vebox-yf-tiled: SKIP (0.000s)
[669.107108] [130/131] (354s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-blt)
[669.204818] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-blt
[669.209055] Subtest fbc-2p-primscrn-cur-indfb-draw-blt: SKIP (0.000s)
[669.330666] [131/131] (354s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-pwrite)
[669.423896] Starting subtest: psr-1p-primscrn-spr-indfb-draw-pwrite
[676.167918] Subtest psr-1p-primscrn-spr-indfb-draw-pwrite: SUCCESS (6.749s)
[676.316609] Closing watchdogs
results: parsing output: 0/ for test: kms_big_fb
results: parsing output: 1/ for test: kms_rotation_crc
results: parsing output: 2/ for test: perf
results: parsing output: 3/ for test: syncobj_wait
results: parsing output: 4/ for test: kms_psr
results: parsing output: 5/ for test: kms_psr2_sf
results: parsing output: 6/ for test: i915_pm_rc6_residency
results: parsing output: 7/ for test: core_getversion
results: parsing output: 8/ for test: kms_frontbuffer_tracking
results: parsing output: 9/ for test: kms_debugfs
results: parsing output: 10/ for test: syncobj_timeline
results: parsing output: 11/ for test: gem_exec_store
results: parsing output: 12/ for test: gem_exec_flush
results: parsing output: 13/ for test: vgem_basic
results: parsing output: 14/ for test: syncobj_timeline
results: parsing output: 15/ for test: kms_legacy_colorkey
results: parsing output: 16/ for test: kms_frontbuffer_tracking
results: parsing output: 17/ for test: kms_rmfb
results: parsing output: 18/ for test: kms_atomic_interruptible
results: parsing output: 19/ for test: gem_ctx_persistence
results: parsing output: 20/ for test: gem_exec_whisper
results: parsing output: 21/ for test: kms_ccs
results: parsing output: 22/ for test: kms_content_protection
results: parsing output: 23/ for test: kms_frontbuffer_tracking
results: parsing output: 24/ for test: syncobj_wait
results: parsing output: 25/ for test: kms_cursor_legacy
results: parsing output: 26/ for test: kms_flip
results: parsing output: 27/ for test: gem_mmap_offset
results: parsing output: 28/ for test: kms_frontbuffer_tracking
results: parsing output: 29/ for test: kms_vblank
results: parsing output: 30/ for test: gem_userptr_blits
results: parsing output: 31/ for test: gem_mmap
results: parsing output: 32/ for test: kms_frontbuffer_tracking
results: parsing output: 33/ for test: kms_frontbuffer_tracking
results: parsing output: 34/ for test: kms_chamelium_color
results: parsing output: 35/ for test: kms_frontbuffer_tracking
results: parsing output: 36/ for test: gem_spin_batch
results: parsing output: 37/ for test: kms_psr
results: parsing output: 38/ for test: kms_psr
results: parsing output: 39/ for test: gem_exec_schedule
results: parsing output: 40/ for test: gem_pxp
results: parsing output: 41/ for test: kms_big_fb
results: parsing output: 42/ for test: kms_frontbuffer_tracking
results: parsing output: 43/ for test: kms_getfb
results: parsing output: 44/ for test: gem_exec_parallel
results: parsing output: 45/ for test: kms_frontbuffer_tracking
results: parsing output: 46/ for test: prime_mmap_coherency
results: parsing output: 47/ for test: kms_3d
results: parsing output: 48/ for test: gem_ctx_param
results: parsing output: 49/ for test: kms_flip_scaled_crc
results: parsing output: 50/ for test: kms_ccs
results: parsing output: 51/ for test: kms_psr2_sf
results: parsing output: 52/ for test: kms_psr
results: parsing output: 53/ for test: syncobj_wait
results: parsing output: 54/ for test: kms_frontbuffer_tracking
results: parsing output: 55/ for test: kms_ccs
results: parsing output: 56/ for test: kms_big_fb
results: parsing output: 57/ for test: kms_frontbuffer_tracking
results: parsing output: 58/ for test: gem_pxp
results: parsing output: 59/ for test: kms_plane
results: parsing output: 60/ for test: perf
results: parsing output: 61/ for test: gem_ctx_param
results: parsing output: 62/ for test: gem_ctx_shared
results: parsing output: 63/ for test: kms_ccs
results: parsing output: 64/ for test: kms_lease
results: parsing output: 65/ for test: gem_exec_reloc
results: parsing output: 66/ for test: syncobj_timeline
results: parsing output: 67/ for test: api_intel_bb
results: parsing output: 68/ for test: kms_flip_scaled_crc
results: parsing output: 69/ for test: kms_ccs
results: parsing output: 70/ for test: sw_sync
results: parsing output: 71/ for test: kms_big_fb
results: parsing output: 72/ for test: kms_frontbuffer_tracking
results: parsing output: 73/ for test: gem_userptr_blits
results: parsing output: 74/ for test: gem_fenced_exec_thrash
results: parsing output: 75/ for test: kms_plane_cursor
results: parsing output: 76/ for test: kms_frontbuffer_tracking
results: parsing output: 77/ for test: syncobj_timeline
results: parsing output: 78/ for test: kms_frontbuffer_tracking
results: parsing output: 79/ for test: gem_exec_reloc
results: parsing output: 80/ for test: gem_exec_reloc
results: parsing output: 81/ for test: kms_vblank
results: parsing output: 82/ for test: gem_exec_balancer
results: parsing output: 83/ for test: syncobj_timeline
results: parsing output: 84/ for test: gem_exec_parallel
results: parsing output: 85/ for test: api_intel_allocator
results: parsing output: 86/ for test: kms_color_pipeline
results: parsing output: 87/ for test: kms_frontbuffer_tracking
results: parsing output: 88/ for test: kms_flip
results: parsing output: 89/ for test: kms_frontbuffer_tracking
results: parsing output: 90/ for test: i915_suspend
results: parsing output: 91/ for test: kms_pm_rpm
results: parsing output: 92/ for test: i915_pm_freq_api
results: parsing output: 93/ for test: i915_drm_fdinfo
results: parsing output: 94/ for test: gem_exec_reloc
results: parsing output: 95/ for test: gen9_exec_parse
results: parsing output: 96/ for test: kms_plane_scaling
results: parsing output: 97/ for test: gem_ctx_isolation
results: parsing output: 98/ for test: kms_feature_discovery
results: parsing output: 99/ for test: perf_pmu
results: parsing output: 100/ for test: gem_ctx_engines
results: parsing output: 101/ for test: kms_big_fb
results: parsing output: 102/ for test: gem_set_tiling_vs_blt
results: parsing output: 103/ for test: kms_chamelium_edid
results: parsing output: 104/ for test: gem_mmap
results: parsing output: 105/ for test: gem_exec_fence
results: parsing output: 106/ for test: kms_cursor_edge_walk
results: parsing output: 107/ for test: syncobj_wait
results: parsing output: 108/ for test: kms_atomic
results: parsing output: 109/ for test: gem_exec_await
results: parsing output: 110/ for test: kms_prop_blob
results: parsing output: 111/ for test: kms_psr
results: parsing output: 112/ for test: gem_userptr_blits
results: parsing output: 113/ for test: syncobj_timeline
results: parsing output: 114/ for test: gem_exec_async
results: parsing output: 115/ for test: kms_plane_scaling
results: parsing output: 116/ for test: gem_mmap_gtt
results: parsing output: 117/ for test: dumb_buffer
results: parsing output: 118/ for test: kms_fbcon_fbt
results: parsing output: 119/ for test: perf
results: parsing output: 120/ for test: kms_cursor_crc
results: parsing output: 121/ for test: kms_cursor_crc
results: parsing output: 122/ for test: kms_cursor_legacy
results: parsing output: 123/ for test: gem_exec_schedule
results: parsing output: 124/ for test: kms_big_fb
results: parsing output: 125/ for test: kms_flip
results: parsing output: 126/ for test: perf_pmu
results: parsing output: 127/ for test: kms_chamelium_hpd
results: parsing output: 128/ for test: gem_render_copy
results: parsing output: 129/ for test: kms_frontbuffer_tracking
results: parsing output: 130/ for test: kms_frontbuffer_tracking
Done.