[60.508437] Initializing watchdogs
[60.508482]   /dev/watchdog0
[60.522865] [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.527206] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[60.529473] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[60.532589] [001/133] (960s left) gem_ctx_param (invalid-size-get)
[60.613658] Starting subtest: invalid-size-get
[60.616022] Subtest invalid-size-get: SUCCESS (0.002s)
[60.724199] [002/133] (960s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-blt)
[60.828524] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-blt
[60.833066] Subtest fbc-2p-primscrn-pri-indfb-draw-blt: SKIP (0.000s)
[60.924808] [003/133] (960s left) template (a)
[60.989896] Starting subtest: A
[60.991824] Subtest A: SUCCESS (0.000s)
[61.094582] [004/133] (960s left) kms_plane_alpha_blend (constant-alpha-mid)
[61.196171] Starting subtest: constant-alpha-mid
[61.495125] Starting dynamic subtest: pipe-A-eDP-1
[62.445868] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.948s)
[62.453736] Starting dynamic subtest: pipe-D-eDP-1
[63.997180] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.550s)
[63.999589] Subtest constant-alpha-mid: SUCCESS (2.799s)
[64.796238] [005/133] (956s left) gem_exec_fence (syncobj-timeline-signal)
[65.355704] Starting subtest: syncobj-timeline-signal
[65.362710] Subtest syncobj-timeline-signal: SUCCESS (0.009s)
[67.218472] [FACT gem_exec_fence (syncobj-timeline-signal)] new: kernel.kmod_is_loaded.vgem: true
[67.222879] [006/133] (954s left) kms_invalid_mode (zero-hdisplay)
[67.354808] Starting subtest: zero-hdisplay
[67.357664] Starting dynamic subtest: pipe-A-eDP-1
[67.635724] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.284s)
[67.646751] Starting dynamic subtest: pipe-B-eDP-1
[67.649023] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[67.659935] Starting dynamic subtest: pipe-C-eDP-1
[67.661931] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[67.668672] Starting dynamic subtest: pipe-D-eDP-1
[67.670665] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[67.672680] Subtest zero-hdisplay: SUCCESS (0.289s)
[68.433647] [007/133] (952s left) kms_psr (fbc-pr-primary-mmap-gtt)
[68.536916] Starting subtest: fbc-pr-primary-mmap-gtt
[68.541392] Subtest fbc-pr-primary-mmap-gtt: SKIP (0.000s)
[68.609394] [008/133] (952s left) kms_cursor_legacy (short-busy-flip-before-cursor-atomic-transitions)
[68.725725] Starting subtest: short-busy-flip-before-cursor-atomic-transitions
[68.730333] Subtest short-busy-flip-before-cursor-atomic-transitions: SKIP (0.000s)
[68.865784] [009/133] (952s left) gem_exec_schedule (preempt)
[68.933631] Starting subtest: preempt
[68.935902] Starting dynamic subtest: rcs0
[68.951461] Dynamic subtest rcs0: SUCCESS (0.026s)
[68.958621] Starting dynamic subtest: bcs0
[68.970881] Dynamic subtest bcs0: SUCCESS (0.019s)
[68.978156] Starting dynamic subtest: vcs0
[68.991535] Dynamic subtest vcs0: SUCCESS (0.020s)
[68.998890] Starting dynamic subtest: vcs1
[69.017392] Dynamic subtest vcs1: SUCCESS (0.026s)
[69.024592] Starting dynamic subtest: vecs0
[69.045273] Dynamic subtest vecs0: SUCCESS (0.027s)
[69.052480] Starting dynamic subtest: ccs0
[69.066826] Dynamic subtest ccs0: SUCCESS (0.021s)
[69.069194] Subtest preempt: SUCCESS (0.141s)
[70.997738] [010/133] (950s left) kms_flip_scaled_crc (flip-64bpp-xtile-to-32bpp-xtile-upscaling)
[71.087465] Starting subtest: flip-64bpp-xtile-to-32bpp-xtile-upscaling
[71.089823] Starting dynamic subtest: pipe-A-default-mode
[73.808215] Dynamic subtest pipe-A-default-mode: SUCCESS (2.719s)
[73.810721] Subtest flip-64bpp-xtile-to-32bpp-xtile-upscaling: SUCCESS (2.720s)
[74.635240] [011/133] (946s left) kms_psr2_su (page_flip-nv12)
[74.690362] Subtest page_flip-NV12: SKIP (0.000s)
[74.752272] [012/133] (946s left) kms_rotation_crc (primary-rotation-270)
[74.851067] Starting subtest: primary-rotation-270
[74.855518] Subtest primary-rotation-270: SKIP (0.001s)
[74.926879] [013/133] (946s left) kms_cursor_edge_walk (256x256-left-edge)
[75.032996] Starting subtest: 256x256-left-edge
[75.035466] Starting dynamic subtest: pipe-A-eDP-1
[78.515222] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.483s)
[78.523787] Starting dynamic subtest: pipe-D-eDP-1
[81.637290] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.118s)
[81.639416] Subtest 256x256-left-edge: SUCCESS (6.603s)
[82.468902] [014/133] (939s left) gem_mmap_gtt (cpuset-big-copy-xy)
[82.524187] Subtest cpuset-big-copy-XY: SKIP (0.000s)
[82.588584] [015/133] (939s left) gem_exec_reloc (basic-gtt)
[82.657664] Subtest basic-gtt: SKIP (0.000s)
[82.735333] [016/133] (938s left) kms_feature_discovery (psr2)
[82.831330] Starting subtest: psr2
[82.833281] Subtest psr2: SUCCESS (0.000s)
[82.906086] [017/133] (938s left) kms_feature_discovery (chamelium)
[83.000951] Starting subtest: chamelium
[83.005631] Subtest chamelium: SKIP (0.000s)
[83.072436] [018/133] (938s left) gem_exec_params (sol-reset-not-gen7)
[83.135548] Starting subtest: sol-reset-not-gen7
[83.140487] Subtest sol-reset-not-gen7: SUCCESS (0.002s)
[83.258183] [019/133] (938s left) kms_content_protection (suspend-resume)
[83.395252] Starting subtest: suspend-resume
[83.398962] Subtest suspend-resume: SKIP (0.000s)
[83.527143] [020/133] (938s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-pwrite)
[83.635995] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-pwrite
[83.639499] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[83.742605] [021/133] (938s left) kms_flip (2x-blocking-wf_vblank)
[83.841066] Starting subtest: 2x-blocking-wf_vblank
[83.850566] Subtest 2x-blocking-wf_vblank: SKIP (0.011s)
[83.967632] [022/133] (937s left) gem_pread (display)
[84.026076] Subtest display: SKIP (0.000s)
[84.081917] [023/133] (937s left) kms_plane_scaling (plane-scaler-with-clipping-clamping-rotation)
[84.182987] Starting subtest: plane-scaler-with-clipping-clamping-rotation
[84.184961] Starting dynamic subtest: pipe-A
[84.415062] Dynamic subtest pipe-A: SUCCESS (0.232s)
[84.423533] Starting dynamic subtest: pipe-B
[85.760632] Dynamic subtest pipe-B: SUCCESS (1.345s)
[85.769345] Starting dynamic subtest: pipe-C
[87.083356] Dynamic subtest pipe-C: SUCCESS (1.322s)
[87.092219] Starting dynamic subtest: pipe-D
[88.417576] Dynamic subtest pipe-D: SUCCESS (1.334s)
[88.419879] Subtest plane-scaler-with-clipping-clamping-rotation: SUCCESS (4.234s)
[89.600751] [024/133] (932s left) gem_render_copy (mixed-tiled-to-yf-tiled-ccs)
[89.674656] Starting subtest: mixed-tiled-to-yf-tiled-ccs
[89.679408] Subtest mixed-tiled-to-yf-tiled-ccs: SKIP (0.000s)
[89.870885] [025/133] (932s left) prime_vgem (fence-wait)
[89.946043] Starting subtest: fence-wait
[89.948537] Starting dynamic subtest: rcs0
[91.014462] Dynamic subtest rcs0: SUCCESS (1.041s)
[91.026084] Starting dynamic subtest: bcs0
[92.045057] Dynamic subtest bcs0: SUCCESS (1.056s)
[92.055446] Starting dynamic subtest: vcs0
[93.096540] Dynamic subtest vcs0: SUCCESS (1.050s)
[93.111945] Starting dynamic subtest: vcs1
[94.142370] Dynamic subtest vcs1: SUCCESS (1.044s)
[94.153522] Starting dynamic subtest: vecs0
[95.186604] Dynamic subtest vecs0: SUCCESS (1.042s)
[95.196581] Starting dynamic subtest: ccs0
[96.230502] Dynamic subtest ccs0: SUCCESS (1.042s)
[96.233486] Subtest fence-wait: SUCCESS (6.283s)
[96.360767] [026/133] (925s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-mmap-wc)
[96.467887] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-mmap-wc
[103.219851] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-mmap-wc: SUCCESS (6.753s)
[103.352534] [027/133] (918s left) api_intel_allocator (gem-pool)
[103.411257] Starting subtest: gem-pool
[103.416365] Subtest gem-pool: SUCCESS (0.008s)
[103.557716] [028/133] (918s left) i915_pm_rps (reset)
[103.615484] Starting subtest: reset
[112.121286] Subtest reset: SUCCESS (8.503s)
[112.245870] [029/133] (909s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-mmap-wc)
[112.347521] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-mmap-wc
[112.351950] Subtest fbc-2p-scndscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[112.438854] [030/133] (909s left) syncobj_timeline (multi-wait-for-submit-unsubmitted-signaled)
[112.501021] Starting subtest: multi-wait-for-submit-unsubmitted-signaled
[112.503451] Subtest multi-wait-for-submit-unsubmitted-signaled: SUCCESS (0.001s)
[112.615670] [031/133] (909s left) vgem_basic (dmabuf-mmap)
[112.656681] Starting subtest: dmabuf-mmap
[112.680446] Subtest dmabuf-mmap: SUCCESS (0.026s)
[112.741346] [032/133] (909s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-mmap-cpu)
[112.850085] Starting subtest: psr-2p-primscrn-pri-indfb-draw-mmap-cpu
[112.854560] Subtest psr-2p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[112.943883] [033/133] (909s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-shrfb-msflip-blt)
[113.039637] Starting subtest: fbcpsr-2p-primscrn-shrfb-msflip-blt
[113.044067] Subtest fbcpsr-2p-primscrn-shrfb-msflip-blt: SKIP (0.000s)
[113.137270] [034/133] (909s left) kms_ccs (crc-primary-suspend-4-tiled-bmg-ccs)
[113.234529] Starting subtest: crc-primary-suspend-4-tiled-bmg-ccs
[113.238310] Subtest crc-primary-suspend-4-tiled-bmg-ccs: SKIP (0.000s)
[114.372264] [035/133] (908s left) kms_flip (2x-dpms-vs-vblank-race)
[114.464312] Starting subtest: 2x-dpms-vs-vblank-race
[114.475517] Subtest 2x-dpms-vs-vblank-race: SKIP (0.011s)
[114.572196] [036/133] (907s left) kms_ccs (bad-pixel-format-4-tiled-mtl-rc-ccs-cc)
[114.660309] Starting subtest: bad-pixel-format-4-tiled-mtl-rc-ccs-cc
[114.662647] Starting dynamic subtest: pipe-A-eDP-1
[114.683851] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s)
[114.694708] Starting dynamic subtest: pipe-B-eDP-1
[114.714471] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[114.722276] Starting dynamic subtest: pipe-C-eDP-1
[114.741973] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[114.749614] Starting dynamic subtest: pipe-D-eDP-1
[114.769197] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[114.771393] Subtest bad-pixel-format-4-tiled-mtl-rc-ccs-cc: SUCCESS (0.005s)
[116.938302] [037/133] (905s left) perf_pmu (invalid-open)
[116.988789] Starting subtest: invalid-open
[116.991124] Subtest invalid-open: SUCCESS (0.000s)
[117.094603] [038/133] (905s left) gem_spin_batch (engines)
[117.159300] Starting subtest: engines
[117.161722] Starting dynamic subtest: rcs0
[120.401363] Dynamic subtest rcs0: SUCCESS (3.237s)
[120.411770] Starting dynamic subtest: bcs0
[123.638902] Dynamic subtest bcs0: SUCCESS (3.235s)
[123.651072] Starting dynamic subtest: vcs0
[126.875528] Dynamic subtest vcs0: SUCCESS (3.236s)
[126.885748] Starting dynamic subtest: vcs1
[130.117569] Dynamic subtest vcs1: SUCCESS (3.239s)
[130.125979] Starting dynamic subtest: vecs0
[133.356201] Dynamic subtest vecs0: SUCCESS (3.238s)
[133.364710] Starting dynamic subtest: ccs0
[136.592036] Dynamic subtest ccs0: SUCCESS (3.234s)
[136.594528] Subtest engines: SUCCESS (19.429s)
[136.815918] [039/133] (885s left) kms_color_pipeline (plane-lut1d-ctm3x4-lut1d)
[136.914114] Starting subtest: plane-lut1d-ctm3x4-lut1d
[137.059528] Starting dynamic subtest: pipe-A-plane-0
[137.238717] Dynamic subtest pipe-A-plane-0: SUCCESS (0.178s)
[137.247788] Starting dynamic subtest: pipe-A-plane-1
[137.392840] Dynamic subtest pipe-A-plane-1: SUCCESS (0.155s)
[137.401474] Starting dynamic subtest: pipe-A-plane-2
[137.559798] Dynamic subtest pipe-A-plane-2: SUCCESS (0.166s)
[138.751804] Starting dynamic subtest: pipe-B-plane-0
[138.922831] Dynamic subtest pipe-B-plane-0: SUCCESS (0.178s)
[138.930935] Starting dynamic subtest: pipe-B-plane-1
[139.089471] Dynamic subtest pipe-B-plane-1: SUCCESS (0.166s)
[139.097423] Starting dynamic subtest: pipe-B-plane-2
[139.243630] Dynamic subtest pipe-B-plane-2: SUCCESS (0.155s)
[140.489891] Starting dynamic subtest: pipe-C-plane-0
[140.634604] Dynamic subtest pipe-C-plane-0: SUCCESS (0.154s)
[140.643770] Starting dynamic subtest: pipe-C-plane-1
[140.801341] Dynamic subtest pipe-C-plane-1: SUCCESS (0.166s)
[140.810461] Starting dynamic subtest: pipe-C-plane-2
[140.945852] Dynamic subtest pipe-C-plane-2: SUCCESS (0.144s)
[142.076618] Starting dynamic subtest: pipe-D-plane-0
[142.225418] Dynamic subtest pipe-D-plane-0: SUCCESS (0.155s)
[142.234262] Starting dynamic subtest: pipe-D-plane-1
[142.392013] Dynamic subtest pipe-D-plane-1: SUCCESS (0.166s)
[142.405835] Starting dynamic subtest: pipe-D-plane-2
[142.547613] Dynamic subtest pipe-D-plane-2: SUCCESS (0.155s)
[142.836276] Subtest plane-lut1d-ctm3x4-lut1d: SUCCESS (5.923s)
[143.651674] [040/133] (878s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-blt)
[143.745457] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-blt
[143.749736] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-blt: SKIP (0.000s)
[143.842834] [041/133] (878s left) gem_ctx_persistence (hang)
[143.906296] Starting subtest: hang
[143.910865] Subtest hang: SKIP (0.000s)
[144.001814] [042/133] (878s left) gem_barrier_race (remote-request)
[144.055846] Starting subtest: remote-request
[144.058217] Starting dynamic subtest: rcs0
[149.285757] Dynamic subtest rcs0: SUCCESS (5.231s)
[149.287948] Subtest remote-request: SUCCESS (5.232s)
[149.415693] [043/133] (873s left) gem_mmap_wc (pf-nonblock)
[149.471535] Subtest pf-nonblock: SKIP (0.000s)
[149.528279] [044/133] (873s left) kms_cursor_legacy (flip-vs-cursor-toggle)
[149.649061] Starting subtest: flip-vs-cursor-toggle
[158.704299] Subtest flip-vs-cursor-toggle: SUCCESS (9.052s)
[159.582777] [045/133] (863s left) kms_chamelium_edid (hdmi-edid-change-during-suspend)
[159.981355] Subtest hdmi-edid-change-during-suspend: SKIP (0.000s)
[160.794902] [046/133] (862s left) kms_big_fb (linear-max-hw-stride-32bpp-rotate-0)
[160.903525] Starting subtest: linear-max-hw-stride-32bpp-rotate-0
[162.037286] Subtest linear-max-hw-stride-32bpp-rotate-0: SUCCESS (1.135s)
[162.185683] [047/133] (860s left) perf (mi-rpc)
[162.281416] Starting subtest: mi-rpc
[162.285445] Subtest mi-rpc: SKIP (0.000s)
[162.324611] [048/133] (860s left) i915_getparams_basic (basic-subslice-total)
[162.372845] Starting subtest: basic-subslice-total
[162.376579] Subtest basic-subslice-total: SUCCESS (0.000s)
[162.461893] [049/133] (860s left) gem_render_copy (y-tiled-mc-ccs-to-vebox-y-tiled)
[162.513967] Starting subtest: y-tiled-mc-ccs-to-vebox-y-tiled
[162.517864] Subtest y-tiled-mc-ccs-to-vebox-y-tiled: SKIP (0.000s)
[162.698495] [050/133] (860s left) gem_exec_whisper (basic-queues-priority-all)
[162.760415] Starting subtest: basic-queues-priority-all
[185.227993] Subtest basic-queues-priority-all: SUCCESS (22.463s)
[185.412579] [051/133] (837s left) kms_pipe_b_c_ivb (enable-pipe-c-while-b-has-3-lanes)
[185.478178] Subtest enable-pipe-C-while-B-has-3-lanes: SKIP (0.000s)
[185.534118] [052/133] (837s left) gem_userptr_blits (forbidden-operations)
[185.595390] Starting subtest: forbidden-operations
[185.599754] Subtest forbidden-operations: SKIP (0.000s)
[185.709579] [053/133] (837s left) kms_cursor_legacy (cursor-vs-flip-atomic-transitions)
[185.828589] Starting subtest: cursor-vs-flip-atomic-transitions
[216.100079] Subtest cursor-vs-flip-atomic-transitions: SUCCESS (30.270s)
[216.945291] [054/133] (806s left) gem_exec_flush (basic-wb-rw-default)
[217.010932] Starting subtest: basic-wb-rw-default
[222.465658] Subtest basic-wb-rw-default: SUCCESS (5.455s)
[222.657831] [055/133] (800s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-0-hflip)
[222.767076] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-0-hflip
[222.771508] Subtest yf-tiled-max-hw-stride-64bpp-rotate-0-hflip: SKIP (0.000s)
[222.872270] [056/133] (800s left) kms_async_flips (test-time-stamp)
[222.961177] Starting subtest: test-time-stamp
[223.341987] Starting dynamic subtest: pipe-A-eDP-1
[224.155924] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.812s)
[224.540139] Starting dynamic subtest: pipe-B-eDP-1
[225.301891] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.765s)
[225.675962] Starting dynamic subtest: pipe-C-eDP-1
[226.436210] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.764s)
[226.802364] Starting dynamic subtest: pipe-D-eDP-1
[227.565657] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.768s)
[227.568046] Subtest test-time-stamp: SUCCESS (4.605s)
[228.730392] [057/133] (794s left) gem_wait (wait)
[228.802955] Starting subtest: wait
[228.805401] Starting dynamic subtest: all-engines
[229.905544] Dynamic subtest all-engines: SUCCESS (1.102s)
[229.915946] Starting dynamic subtest: rcs0
[230.950538] Dynamic subtest rcs0: SUCCESS (1.043s)
[230.960828] Starting dynamic subtest: bcs0
[231.997168] Dynamic subtest bcs0: SUCCESS (1.045s)
[232.007892] Starting dynamic subtest: vcs0
[233.042268] Dynamic subtest vcs0: SUCCESS (1.043s)
[233.053076] Starting dynamic subtest: vcs1
[234.086502] Dynamic subtest vcs1: SUCCESS (1.042s)
[234.097768] Starting dynamic subtest: vecs0
[235.132096] Dynamic subtest vecs0: SUCCESS (1.043s)
[235.142652] Starting dynamic subtest: ccs0
[236.179120] Dynamic subtest ccs0: SUCCESS (1.045s)
[236.181668] Subtest wait: SUCCESS (7.377s)
[236.394609] [058/133] (786s left) syncobj_wait (multi-wait-all-for-submit-unsubmitted-submitted)
[236.456381] Starting subtest: multi-wait-all-for-submit-unsubmitted-submitted
[236.560361] Subtest multi-wait-all-for-submit-unsubmitted-submitted: SUCCESS (0.103s)
[236.634776] [059/133] (786s left) kms_pm_rpm (dpms-lpsp)
[238.159217] Starting subtest: dpms-lpsp
[238.807756] Subtest dpms-lpsp: SUCCESS (0.651s)
[238.928196] [060/133] (784s left) gem_exec_fence (syncobj-timeline-repeat)
[239.491981] Starting subtest: syncobj-timeline-repeat
[239.730884] Subtest syncobj-timeline-repeat: SUCCESS (0.243s)
[241.003311] [061/133] (782s left) kms_psr (fbc-psr-dpms)
[241.095646] Starting subtest: fbc-psr-dpms
[241.097766] Starting dynamic subtest: eDP-1
[241.102116] Dynamic subtest eDP-1: SKIP (0.000s)
[241.106424] Subtest fbc-psr-dpms: SKIP (0.001s)
[241.166446] [062/133] (782s left) kms_setmode (invalid-clone-single-crtc)
[241.220230] Starting subtest: invalid-clone-single-crtc
[241.226743] Subtest invalid-clone-single-crtc: SKIP (0.000s)
[241.321598] [063/133] (782s left) gem_mmap_offset (clear-via-pagefault)
[241.372518] Starting subtest: clear-via-pagefault
[241.374719] Starting dynamic subtest: smem0
[275.495769] Dynamic subtest smem0: SUCCESS (34.118s)
[275.498522] Subtest clear-via-pagefault: SUCCESS (34.120s)
[275.627384] [064/133] (747s left) kms_atomic_interruptible (universal-setplane-cursor)
[275.714974] Starting subtest: universal-setplane-cursor
[275.717228] Starting dynamic subtest: pipe-A-eDP-1
[283.183226] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.465s)
[283.185523] Subtest universal-setplane-cursor: SUCCESS (7.466s)
[284.028489] [065/133] (739s left) gem_exec_balancer (parallel-contexts)
[284.288863] Starting subtest: parallel-contexts
[287.564104] Subtest parallel-contexts: SUCCESS (3.274s)
[288.094872] [066/133] (735s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-shrfb-plflip-blt)
[288.209632] Starting subtest: fbcpsr-2p-scndscrn-shrfb-plflip-blt
[288.214075] Subtest fbcpsr-2p-scndscrn-shrfb-plflip-blt: SKIP (0.000s)
[288.307986] [067/133] (735s left) gem_eio (context-create)
[288.527613] Starting subtest: context-create
[288.853307] Subtest context-create: SUCCESS (0.325s)
[288.986365] [068/133] (734s left) kms_big_fb (y-tiled-8bpp-rotate-90)
[289.088531] Starting subtest: y-tiled-8bpp-rotate-90
[289.092296] Subtest y-tiled-8bpp-rotate-90: SKIP (0.000s)
[289.185069] [069/133] (734s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-0-hflip)
[289.284238] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-0-hflip
[290.308516] Subtest 4-tiled-max-hw-stride-32bpp-rotate-0-hflip: SUCCESS (1.024s)
[290.418452] [070/133] (733s left) kms_vblank (ts-continuation-dpms-suspend)
[290.520458] Starting subtest: ts-continuation-dpms-suspend
[290.522335] Starting dynamic subtest: pipe-A-eDP-1
[307.965910] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.019s)
[307.980652] Starting dynamic subtest: pipe-D-eDP-1
[325.971695] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.487s)
[325.974498] Subtest ts-continuation-dpms-suspend: SUCCESS (4.511s)
[326.823217] [071/133] (697s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-mmap-wc)
[326.935848] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-mmap-wc
[331.195805] Subtest fbc-1p-primscrn-pri-indfb-draw-mmap-wc: SUCCESS (4.257s)
[332.404574] [072/133] (691s left) vgem_basic (dmabuf-export)
[332.451963] Starting subtest: dmabuf-export
[332.477965] Subtest dmabuf-export: SUCCESS (0.028s)
[332.577269] [073/133] (691s left) kms_psr2_sf (pr-cursor-plane-move-continuous-exceed-fully-sf)
[332.671692] Starting subtest: pr-cursor-plane-move-continuous-exceed-fully-sf
[332.676039] Subtest pr-cursor-plane-move-continuous-exceed-fully-sf: SKIP (0.000s)
[332.753435] [074/133] (691s left) drm_read (empty-block)
[332.889962] Starting subtest: empty-block
[333.891780] Subtest empty-block: SUCCESS (0.999s)
[334.030883] [075/133] (690s left) syncobj_wait (reset-during-wait-for-submit)
[334.094171] Starting subtest: reset-during-wait-for-submit
[334.198508] Subtest reset-during-wait-for-submit: SUCCESS (0.103s)
[334.290264] [076/133] (689s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip)
[334.399943] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip
[335.058815] Subtest x-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip: SUCCESS (0.660s)
[335.235253] [077/133] (688s left) gem_exec_balancer (full)
[335.286166] Starting subtest: full
[339.686989] Subtest full: SUCCESS (4.397s)
[339.992287] [078/133] (684s left) kms_frontbuffer_tracking (psr-indfb-scaledprimary)
[340.086452] Starting subtest: psr-indfb-scaledprimary
[345.893810] Subtest psr-indfb-scaledprimary: SUCCESS (5.805s)
[346.024293] [079/133] (678s left) gem_exec_schedule (semaphore-codependency)
[346.103234] Starting subtest: semaphore-codependency
[346.108590] Subtest semaphore-codependency: SUCCESS (0.015s)
[346.447877] [080/133] (677s left) syncobj_timeline (wait-all-complex)
[346.502939] Starting subtest: wait-all-complex
[346.718018] Subtest wait-all-complex: SUCCESS (0.216s)
[346.799774] [081/133] (677s left) kms_ccs (bad-rotation-90-y-tiled-gen12-rc-ccs)
[346.891938] Starting subtest: bad-rotation-90-y-tiled-gen12-rc-ccs
[346.894883] Starting dynamic subtest: pipe-A-eDP-1
[346.921720] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[346.933864] Starting dynamic subtest: pipe-B-eDP-1
[346.959727] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[346.968936] Starting dynamic subtest: pipe-C-eDP-1
[346.994348] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[347.003485] Starting dynamic subtest: pipe-D-eDP-1
[347.029358] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[347.034557] Subtest bad-rotation-90-y-tiled-gen12-rc-ccs: SKIP (0.004s)
[349.192707] [082/133] (675s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-180-async-flip)
[349.302975] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-180-async-flip
[350.137656] Subtest 4-tiled-max-hw-stride-64bpp-rotate-180-async-flip: SUCCESS (0.837s)
[350.306816] [083/133] (674s left) kms_plane (pixel-format-4-tiled-dg2-rc-ccs-modifier-source-clamping)
[350.406665] Starting subtest: pixel-format-4-tiled-dg2-rc-ccs-modifier-source-clamping
[350.411690] Subtest pixel-format-4-tiled-dg2-rc-ccs-modifier-source-clamping: SKIP (0.000s)
[350.489476] [084/133] (673s left) gem_create (create-ext-placement-all)
[350.657226] Starting subtest: create-ext-placement-all
[350.660324] Subtest create-ext-placement-all: SUCCESS (0.000s)
[350.772421] [085/133] (673s left) kms_cursor_legacy (long-nonblocking-modeset-vs-cursor-atomic)
[350.897735] Starting subtest: long-nonblocking-modeset-vs-cursor-atomic
[368.591855] Subtest long-nonblocking-modeset-vs-cursor-atomic: SUCCESS (17.682s)
[369.386637] [086/133] (655s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-mmap-cpu)
[369.495589] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-mmap-cpu
[369.500514] Subtest fbc-2p-scndscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[369.590472] [087/133] (655s left) gen7_exec_parse (bitmasks)
[369.639718] Subtest bitmasks: SKIP (0.000s)
[369.710589] [088/133] (654s left) gem_eio (in-flight-contexts-1us)
[369.927233] Starting subtest: in-flight-contexts-1us
[383.874274] Subtest in-flight-contexts-1us: SUCCESS (13.942s)
[384.007156] [089/133] (640s left) gem_exec_suspend (basic-s3-devices)
[384.070217] Starting subtest: basic-S3-devices
[384.072753] Starting dynamic subtest: smem
[395.819970] Dynamic subtest smem: SUCCESS (11.744s)
[395.823434] Subtest basic-S3-devices: SUCCESS (11.746s)
[396.008660] [090/133] (628s left) gem_exec_params (invalid-ring2)
[396.074410] Starting subtest: invalid-ring2
[396.077179] Subtest invalid-ring2: SUCCESS (0.000s)
[396.179779] [091/133] (628s left) i915_query (test-query-geometry-subslices)
[396.235823] Starting subtest: test-query-geometry-subslices
[396.238522] Subtest test-query-geometry-subslices: SUCCESS (0.000s)
[396.327777] [092/133] (628s left) kms_universal_plane (disable-primary-vs-flip)
[396.421608] Starting subtest: disable-primary-vs-flip
[396.424453] Starting dynamic subtest: pipe-A-eDP-1
[397.998853] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.578s)
[398.009864] Starting dynamic subtest: pipe-B-eDP-1
[400.219844] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.220s)
[400.230885] Starting dynamic subtest: pipe-C-eDP-1
[402.404833] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.183s)
[402.417784] Starting dynamic subtest: pipe-D-eDP-1
[404.644718] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.239s)
[404.647721] Subtest disable-primary-vs-flip: SUCCESS (8.226s)
[405.443679] [093/133] (619s left) kms_vrr (seamless-rr-switch-drrs)
[405.543155] Starting subtest: seamless-rr-switch-drrs
[405.549675] Subtest seamless-rr-switch-drrs: SKIP (0.000s)
[405.618606] [094/133] (619s left) gem_exec_params (dr4-dirt)
[405.676858] Starting subtest: DR4-dirt
[405.679779] Subtest DR4-dirt: SUCCESS (0.000s)
[405.774912] [095/133] (619s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-mmap-cpu)
[405.869717] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-mmap-cpu
[405.874582] Subtest fbc-2p-scndscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[405.969068] [096/133] (619s left) kms_plane_scaling (plane-scaler-unity-scaling-with-rotation)
[406.057348] Starting subtest: plane-scaler-unity-scaling-with-rotation
[406.059683] Starting dynamic subtest: pipe-A
[406.298068] Dynamic subtest pipe-A: SUCCESS (0.239s)
[406.312969] Starting dynamic subtest: pipe-B
[407.626227] Dynamic subtest pipe-B: SUCCESS (1.325s)
[407.638574] Starting dynamic subtest: pipe-C
[408.963207] Dynamic subtest pipe-C: SUCCESS (1.336s)
[408.973178] Starting dynamic subtest: pipe-D
[410.297920] Dynamic subtest pipe-D: SUCCESS (1.334s)
[410.300767] Subtest plane-scaler-unity-scaling-with-rotation: SUCCESS (4.241s)
[411.493754] [097/133] (613s left) i915_drm_fdinfo (context-close-stress)
[411.534714] Starting subtest: context-close-stress
[422.280702] Subtest context-close-stress: SUCCESS (10.745s)
[422.357940] [098/133] (602s left) kms_chamelium_hpd (dp-hpd-storm)
[422.912588] Subtest dp-hpd-storm: SKIP (0.000s)
[423.703981] [099/133] (601s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-wc)
[423.809661] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-wc
[431.095736] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-wc: SUCCESS (7.287s)
[431.208488] [100/133] (593s left) syncobj_timeline (etime-multi-wait-for-submit-submitted)
[431.263750] Starting subtest: etime-multi-wait-for-submit-submitted
[431.367111] Subtest etime-multi-wait-for-submit-submitted: SUCCESS (0.104s)
[431.445054] [101/133] (593s left) perf_pmu (all-busy-idle-check-all)
[431.490669] Starting subtest: all-busy-idle-check-all
[432.876275] Subtest all-busy-idle-check-all: SUCCESS (1.386s)
[432.971056] [102/133] (592s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-blt)
[433.068400] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-blt
[440.386878] Subtest psr-1p-primscrn-pri-shrfb-draw-blt: SUCCESS (7.320s)
[440.502927] [103/133] (584s left) kms_frontbuffer_tracking (psr-1p-primscrn-shrfb-msflip-blt)
[440.609509] Starting subtest: psr-1p-primscrn-shrfb-msflip-blt
[447.936626] Subtest psr-1p-primscrn-shrfb-msflip-blt: SUCCESS (7.332s)
[448.066972] [104/133] (577s left) kms_joiner (switch-modeset-ultra-joiner-big-joiner)
[448.182361] Starting subtest: switch-modeset-ultra-joiner-big-joiner
[448.187156] Subtest switch-modeset-ultra-joiner-big-joiner: SKIP (0.000s)
[448.256056] [105/133] (577s left) kms_cursor_crc (cursor-offscreen-256x256)
[448.477439] Starting subtest: cursor-offscreen-256x256
[448.483021] Starting dynamic subtest: pipe-A-eDP-1
[450.440925] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.957s)
[450.470167] Starting dynamic subtest: pipe-D-eDP-1
[453.012546] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.545s)
[453.014956] Subtest cursor-offscreen-256x256: SUCCESS (4.530s)
[453.862975] [106/133] (571s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-mmap-cpu)
[453.972664] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-mmap-cpu
[453.977467] Subtest fbc-2p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[454.075608] [107/133] (571s left) kms_async_flips (alternate-sync-async-flip-atomic)
[454.158570] Starting subtest: alternate-sync-async-flip-atomic
[454.534923] Starting dynamic subtest: pipe-A-eDP-1
[457.346333] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.813s)
[457.738453] Starting dynamic subtest: pipe-B-eDP-1
[460.485600] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.755s)
[460.882554] Starting dynamic subtest: pipe-C-eDP-1
[463.623575] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.751s)
[463.992813] Starting dynamic subtest: pipe-D-eDP-1
[466.757201] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.774s)
[466.759575] Subtest alternate-sync-async-flip-atomic: SUCCESS (12.600s)
[467.926684] [108/133] (557s left) syncobj_eventfd (invalid-bad-flags)
[467.983835] Starting subtest: invalid-bad-flags
[467.986843] Subtest invalid-bad-flags: SUCCESS (0.000s)
[468.074625] [109/133] (557s left) kms_ccs (bad-aux-stride-4-tiled-mtl-rc-ccs-cc)
[468.175493] Starting subtest: bad-aux-stride-4-tiled-mtl-rc-ccs-cc
[468.177764] Starting dynamic subtest: pipe-A-eDP-1
[468.198224] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[468.208366] Starting dynamic subtest: pipe-B-eDP-1
[468.230802] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[468.240881] Starting dynamic subtest: pipe-C-eDP-1
[468.263468] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[468.272884] Starting dynamic subtest: pipe-D-eDP-1
[468.296292] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[468.298718] Subtest bad-aux-stride-4-tiled-mtl-rc-ccs-cc: SUCCESS (0.008s)
[470.505987] [110/133] (555s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-render)
[470.605756] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-render
[470.610872] Subtest psr-2p-scndscrn-cur-indfb-draw-render: SKIP (0.000s)
[470.703789] [111/133] (554s left) kms_getfb (getfb-reject-nv12)
[470.798454] Starting subtest: getfb-reject-nv12
[470.800802] Subtest getfb-reject-nv12: SUCCESS (0.001s)
[470.894710] [112/133] (554s left) kms_chamelium_color (ctm-blue-to-red)
[470.988095] Subtest ctm-blue-to-red: SKIP (0.000s)
[471.038211] [113/133] (554s left) syncobj_timeline (multi-wait-all-available-submitted-signaled)
[471.093487] Starting subtest: multi-wait-all-available-submitted-signaled
[471.095690] Subtest multi-wait-all-available-submitted-signaled: SUCCESS (0.000s)
[471.202790] [114/133] (554s left) gem_caching (writes)
[471.264723] Subtest writes: SKIP (0.000s)
[471.334241] [115/133] (554s left) kms_psr (psr-suspend)
[471.432640] Starting subtest: psr-suspend
[471.435244] Starting dynamic subtest: eDP-1
[488.820292] Dynamic subtest eDP-1: SUCCESS (2.917s)
[488.822690] Subtest psr-suspend: SUCCESS (2.918s)
[489.695986] [116/133] (536s left) kms_psr (psr2-cursor-blt)
[489.787503] Starting subtest: psr2-cursor-blt
[489.789891] Starting dynamic subtest: eDP-1
[491.478919] Dynamic subtest eDP-1: SUCCESS (1.690s)
[491.481913] Subtest psr2-cursor-blt: SUCCESS (1.691s)
[492.354420] [117/133] (533s left) kms_psr (psr-basic)
[492.443286] Starting subtest: psr-basic
[492.445921] Starting dynamic subtest: eDP-1
[494.030658] Dynamic subtest eDP-1: SUCCESS (1.585s)
[494.033036] Subtest psr-basic: SUCCESS (1.586s)
[494.905299] [118/133] (531s left) gem_exec_reloc (basic-write-gtt)
[494.963827] Subtest basic-write-gtt: SKIP (0.000s)
[495.036795] [119/133] (530s left) kms_flip (2x-flip-vs-fences)
[495.140748] Starting subtest: 2x-flip-vs-fences
[495.146064] Subtest 2x-flip-vs-fences: SKIP (0.000s)
[495.243008] [120/133] (530s left) kms_atomic_transition (plane-all-transition)
[495.326012] Starting subtest: plane-all-transition
[495.328321] Starting dynamic subtest: pipe-A-eDP-1
[497.824427] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.496s)
[498.137524] Starting dynamic subtest: pipe-B-eDP-1
[501.349178] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.219s)
[501.645614] Subtest plane-all-transition: SUCCESS (6.315s)
[502.479560] [121/133] (523s left) gem_ctx_persistence (engines-hostile)
[502.542018] Starting subtest: engines-hostile
[502.544915] Starting dynamic subtest: rcs0
[502.604723] Dynamic subtest rcs0: SUCCESS (0.062s)
[502.615704] Starting dynamic subtest: bcs0
[502.696856] Dynamic subtest bcs0: SUCCESS (0.090s)
[502.709542] Starting dynamic subtest: vcs0
[502.790888] Dynamic subtest vcs0: SUCCESS (0.092s)
[502.802595] Starting dynamic subtest: vcs1
[502.887864] Dynamic subtest vcs1: SUCCESS (0.095s)
[502.900520] Starting dynamic subtest: vecs0
[502.988997] Dynamic subtest vecs0: SUCCESS (0.099s)
[503.000891] Starting dynamic subtest: ccs0
[503.065888] Dynamic subtest ccs0: SUCCESS (0.075s)
[503.068580] Subtest engines-hostile: SUCCESS (0.525s)
[503.179443] [122/133] (522s left) kms_plane_cursor (primary)
[503.275388] Starting subtest: primary
[503.279929] Starting dynamic subtest: pipe-A-eDP-1-size-64
[505.830912] Dynamic subtest pipe-A-eDP-1-size-64: SUCCESS (2.554s)
[505.854845] Starting dynamic subtest: pipe-A-eDP-1-size-128
[508.409996] Dynamic subtest pipe-A-eDP-1-size-128: SUCCESS (2.560s)
[508.439786] Starting dynamic subtest: pipe-A-eDP-1-size-256
[510.994052] Dynamic subtest pipe-A-eDP-1-size-256: SUCCESS (2.561s)
[511.310642] Starting dynamic subtest: pipe-B-eDP-1-size-64
[514.603408] Dynamic subtest pipe-B-eDP-1-size-64: SUCCESS (3.304s)
[514.629038] Starting dynamic subtest: pipe-B-eDP-1-size-128
[517.217167] Dynamic subtest pipe-B-eDP-1-size-128: SUCCESS (2.594s)
[517.241619] Starting dynamic subtest: pipe-B-eDP-1-size-256
[519.886225] Dynamic subtest pipe-B-eDP-1-size-256: SUCCESS (2.650s)
[520.207892] Starting dynamic subtest: pipe-C-eDP-1-size-64
[523.222456] Dynamic subtest pipe-C-eDP-1-size-64: SUCCESS (3.035s)
[523.252412] Starting dynamic subtest: pipe-C-eDP-1-size-128
[525.478032] Dynamic subtest pipe-C-eDP-1-size-128: SUCCESS (2.236s)
[525.504590] Starting dynamic subtest: pipe-C-eDP-1-size-256
[527.743357] Dynamic subtest pipe-C-eDP-1-size-256: SUCCESS (2.247s)
[528.062001] Starting dynamic subtest: pipe-D-eDP-1-size-64
[531.041222] Dynamic subtest pipe-D-eDP-1-size-64: SUCCESS (2.994s)
[531.066398] Starting dynamic subtest: pipe-D-eDP-1-size-128
[533.296411] Dynamic subtest pipe-D-eDP-1-size-128: SUCCESS (2.237s)
[533.326026] Starting dynamic subtest: pipe-D-eDP-1-size-256
[535.529719] Dynamic subtest pipe-D-eDP-1-size-256: SUCCESS (2.214s)
[535.835265] Subtest primary: SUCCESS (32.557s)
[536.710012] [123/133] (489s left) gem_exec_params (no-blt)
[536.786755] Starting subtest: no-blt
[536.789271] Subtest no-blt: SUCCESS (0.002s)
[536.897523] [124/133] (489s left) kms_cursor_crc (cursor-size-hints)
[537.017929] Starting subtest: cursor-size-hints
[537.020393] Starting dynamic subtest: pipe-A-eDP-1
[537.653865] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.633s)
[537.663960] Starting dynamic subtest: pipe-D-eDP-1
[538.874084] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.219s)
[538.876998] Subtest cursor-size-hints: SUCCESS (1.855s)
[539.687699] [125/133] (486s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-16bpp-ytile-upscaling)
[539.778473] Starting subtest: flip-64bpp-ytile-to-16bpp-ytile-upscaling
[539.783598] Subtest flip-64bpp-ytile-to-16bpp-ytile-upscaling: SKIP (0.000s)
[539.853853] [126/133] (486s left) gem_exec_reloc (basic-gtt-wc-noreloc)
[539.908927] Subtest basic-gtt-wc-noreloc: SKIP (0.000s)
[539.978056] [127/133] (486s left) sysfs_timeslice_duration (idempotent)
[540.031313] Starting subtest: idempotent
[540.033758] Starting dynamic subtest: vecs0
[540.036126] Dynamic subtest vecs0: SUCCESS (0.000s)
[540.046592] Starting dynamic subtest: ccs0
[540.048936] Dynamic subtest ccs0: SUCCESS (0.000s)
[540.058889] Starting dynamic subtest: vcs0
[540.061279] Dynamic subtest vcs0: SUCCESS (0.000s)
[540.070568] Starting dynamic subtest: bcs0
[540.072799] Dynamic subtest bcs0: SUCCESS (0.000s)
[540.082380] Starting dynamic subtest: rcs0
[540.084899] Dynamic subtest rcs0: SUCCESS (0.000s)
[540.094667] Starting dynamic subtest: vcs1
[540.096813] Dynamic subtest vcs1: SUCCESS (0.000s)
[540.098875] Subtest idempotent: SUCCESS (0.006s)
[540.139887] [128/133] (486s left) kms_ccs (crc-sprite-planes-basic-4-tiled-mtl-rc-ccs)
[540.231402] Starting subtest: crc-sprite-planes-basic-4-tiled-mtl-rc-ccs
[540.233823] Starting dynamic subtest: pipe-A-eDP-1
[540.738688] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.485s)
[540.748976] Starting dynamic subtest: pipe-B-eDP-1
[542.252736] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.505s)
[542.263082] Starting dynamic subtest: pipe-C-eDP-1
[543.616945] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.362s)
[543.627938] Starting dynamic subtest: pipe-D-eDP-1
[545.053817] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.435s)
[545.056468] Subtest crc-sprite-planes-basic-4-tiled-mtl-rc-ccs: SUCCESS (4.791s)
[546.206527] [129/133] (480s left) api_intel_bb (object-reloc-purge-cache)
[546.266287] Starting subtest: object-reloc-purge-cache
[546.270894] Subtest object-reloc-purge-cache: SKIP (0.003s)
[546.352150] [130/133] (480s left) device_reset (unbind-cold-reset-rebind)
[546.398763] Starting subtest: unbind-cold-reset-rebind
[546.403791] Subtest unbind-cold-reset-rebind: SKIP (0.000s)
[546.470477] [131/133] (480s left) gem_exec_whisper (basic-contexts-forked)
[546.532283] Starting subtest: basic-contexts-forked
[569.947521] Subtest basic-contexts-forked: SUCCESS (23.404s)
[570.139824] [132/133] (456s left) kms_prop_blob (invalid-get-prop)
[570.195889] Starting subtest: invalid-get-prop
[570.198714] Subtest invalid-get-prop: SUCCESS (0.000s)
[570.301274] [133/133] (456s left) kms_pm_rpm (modeset-non-lpsp)
[572.550744] Starting subtest: modeset-non-lpsp
[573.694618] Subtest modeset-non-lpsp: SKIP (1.145s)
[574.069980] Closing watchdogs
results: parsing output: 0/ for test: gem_ctx_param
results: parsing output: 1/ for test: kms_frontbuffer_tracking
results: parsing output: 2/ for test: template
results: parsing output: 3/ for test: kms_plane_alpha_blend
results: parsing output: 4/ for test: gem_exec_fence
results: parsing output: 5/ for test: kms_invalid_mode
results: parsing output: 6/ for test: kms_psr
results: parsing output: 7/ for test: kms_cursor_legacy
results: parsing output: 8/ for test: gem_exec_schedule
results: parsing output: 9/ for test: kms_flip_scaled_crc
results: parsing output: 10/ for test: kms_psr2_su
results: parsing output: 11/ for test: kms_rotation_crc
results: parsing output: 12/ for test: kms_cursor_edge_walk
results: parsing output: 13/ for test: gem_mmap_gtt
results: parsing output: 14/ for test: gem_exec_reloc
results: parsing output: 15/ for test: kms_feature_discovery
results: parsing output: 16/ for test: kms_feature_discovery
results: parsing output: 17/ for test: gem_exec_params
results: parsing output: 18/ for test: kms_content_protection
results: parsing output: 19/ for test: kms_frontbuffer_tracking
results: parsing output: 20/ for test: kms_flip
results: parsing output: 21/ for test: gem_pread
results: parsing output: 22/ for test: kms_plane_scaling
results: parsing output: 23/ for test: gem_render_copy
results: parsing output: 24/ for test: prime_vgem
results: parsing output: 25/ for test: kms_frontbuffer_tracking
results: parsing output: 26/ for test: api_intel_allocator
results: parsing output: 27/ for test: i915_pm_rps
results: parsing output: 28/ for test: kms_frontbuffer_tracking
results: parsing output: 29/ for test: syncobj_timeline
results: parsing output: 30/ for test: vgem_basic
results: parsing output: 31/ for test: kms_frontbuffer_tracking
results: parsing output: 32/ for test: kms_frontbuffer_tracking
results: parsing output: 33/ for test: kms_ccs
results: parsing output: 34/ for test: kms_flip
results: parsing output: 35/ for test: kms_ccs
results: parsing output: 36/ for test: perf_pmu
results: parsing output: 37/ for test: gem_spin_batch
results: parsing output: 38/ for test: kms_color_pipeline
results: parsing output: 39/ for test: kms_frontbuffer_tracking
results: parsing output: 40/ for test: gem_ctx_persistence
results: parsing output: 41/ for test: gem_barrier_race
results: parsing output: 42/ for test: gem_mmap_wc
results: parsing output: 43/ for test: kms_cursor_legacy
results: parsing output: 44/ for test: kms_chamelium_edid
results: parsing output: 45/ for test: kms_big_fb
results: parsing output: 46/ for test: perf
results: parsing output: 47/ for test: i915_getparams_basic
results: parsing output: 48/ for test: gem_render_copy
results: parsing output: 49/ for test: gem_exec_whisper
results: parsing output: 50/ for test: kms_pipe_b_c_ivb
results: parsing output: 51/ for test: gem_userptr_blits
results: parsing output: 52/ for test: kms_cursor_legacy
results: parsing output: 53/ for test: gem_exec_flush
results: parsing output: 54/ for test: kms_big_fb
results: parsing output: 55/ for test: kms_async_flips
results: parsing output: 56/ for test: gem_wait
results: parsing output: 57/ for test: syncobj_wait
results: parsing output: 58/ for test: kms_pm_rpm
results: parsing output: 59/ for test: gem_exec_fence
results: parsing output: 60/ for test: kms_psr
results: parsing output: 61/ for test: kms_setmode
results: parsing output: 62/ for test: gem_mmap_offset
results: parsing output: 63/ for test: kms_atomic_interruptible
results: parsing output: 64/ for test: gem_exec_balancer
results: parsing output: 65/ for test: kms_frontbuffer_tracking
results: parsing output: 66/ for test: gem_eio
results: parsing output: 67/ for test: kms_big_fb
results: parsing output: 68/ for test: kms_big_fb
results: parsing output: 69/ for test: kms_vblank
results: parsing output: 70/ for test: kms_frontbuffer_tracking
results: parsing output: 71/ for test: vgem_basic
results: parsing output: 72/ for test: kms_psr2_sf
results: parsing output: 73/ for test: drm_read
results: parsing output: 74/ for test: syncobj_wait
results: parsing output: 75/ for test: kms_big_fb
results: parsing output: 76/ for test: gem_exec_balancer
results: parsing output: 77/ for test: kms_frontbuffer_tracking
results: parsing output: 78/ for test: gem_exec_schedule
results: parsing output: 79/ for test: syncobj_timeline
results: parsing output: 80/ for test: kms_ccs
results: parsing output: 81/ for test: kms_big_fb
results: parsing output: 82/ for test: kms_plane
results: parsing output: 83/ for test: gem_create
results: parsing output: 84/ for test: kms_cursor_legacy
results: parsing output: 85/ for test: kms_frontbuffer_tracking
results: parsing output: 86/ for test: gen7_exec_parse
results: parsing output: 87/ for test: gem_eio
results: parsing output: 88/ for test: gem_exec_suspend
results: parsing output: 89/ for test: gem_exec_params
results: parsing output: 90/ for test: i915_query
results: parsing output: 91/ for test: kms_universal_plane
results: parsing output: 92/ for test: kms_vrr
results: parsing output: 93/ for test: gem_exec_params
results: parsing output: 94/ for test: kms_frontbuffer_tracking
results: parsing output: 95/ for test: kms_plane_scaling
results: parsing output: 96/ for test: i915_drm_fdinfo
results: parsing output: 97/ for test: kms_chamelium_hpd
results: parsing output: 98/ for test: kms_frontbuffer_tracking
results: parsing output: 99/ for test: syncobj_timeline
results: parsing output: 100/ for test: perf_pmu
results: parsing output: 101/ for test: kms_frontbuffer_tracking
results: parsing output: 102/ for test: kms_frontbuffer_tracking
results: parsing output: 103/ for test: kms_joiner
results: parsing output: 104/ for test: kms_cursor_crc
results: parsing output: 105/ for test: kms_frontbuffer_tracking
results: parsing output: 106/ for test: kms_async_flips
results: parsing output: 107/ for test: syncobj_eventfd
results: parsing output: 108/ for test: kms_ccs
results: parsing output: 109/ for test: kms_frontbuffer_tracking
results: parsing output: 110/ for test: kms_getfb
results: parsing output: 111/ for test: kms_chamelium_color
results: parsing output: 112/ for test: syncobj_timeline
results: parsing output: 113/ for test: gem_caching
results: parsing output: 114/ for test: kms_psr
results: parsing output: 115/ for test: kms_psr
results: parsing output: 116/ for test: kms_psr
results: parsing output: 117/ for test: gem_exec_reloc
results: parsing output: 118/ for test: kms_flip
results: parsing output: 119/ for test: kms_atomic_transition
results: parsing output: 120/ for test: gem_ctx_persistence
results: parsing output: 121/ for test: kms_plane_cursor
results: parsing output: 122/ for test: gem_exec_params
results: parsing output: 123/ for test: kms_cursor_crc
results: parsing output: 124/ for test: kms_flip_scaled_crc
results: parsing output: 125/ for test: gem_exec_reloc
results: parsing output: 126/ for test: sysfs_timeslice_duration
results: parsing output: 127/ for test: kms_ccs
results: parsing output: 128/ for test: api_intel_bb
results: parsing output: 129/ for test: device_reset
results: parsing output: 130/ for test: gem_exec_whisper
results: parsing output: 131/ for test: kms_prop_blob
results: parsing output: 132/ for test: kms_pm_rpm
Done.