[56.876329] Initializing watchdogs
[56.876376]   /dev/watchdog0
[56.890893] [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]
[56.895547] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[56.897784] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[56.901337] [001/133] (960s left) gem_ctx_param (invalid-size-get)
[56.979597] Starting subtest: invalid-size-get
[56.982092] Subtest invalid-size-get: SUCCESS (0.002s)
[57.106064] [002/133] (960s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-blt)
[57.223620] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-blt
[57.227707] Subtest fbc-2p-primscrn-pri-indfb-draw-blt: SKIP (0.000s)
[57.327754] [003/133] (960s left) template (a)
[57.388825] Starting subtest: A
[57.391281] Subtest A: SUCCESS (0.000s)
[57.503448] [004/133] (960s left) kms_plane_alpha_blend (constant-alpha-mid)
[57.586457] Starting subtest: constant-alpha-mid
[57.888243] Starting dynamic subtest: pipe-A-eDP-1
[58.857612] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.969s)
[58.864095] Starting dynamic subtest: pipe-D-eDP-1
[60.357236] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.500s)
[60.359694] Subtest constant-alpha-mid: SUCCESS (2.775s)
[61.179453] [005/133] (956s left) gem_exec_fence (syncobj-timeline-signal)
[61.743393] Starting subtest: syncobj-timeline-signal
[61.750028] Subtest syncobj-timeline-signal: SUCCESS (0.008s)
[62.986150] [FACT gem_exec_fence (syncobj-timeline-signal)] new: kernel.kmod_is_loaded.vgem: true
[62.989470] [006/133] (954s left) kms_invalid_mode (zero-hdisplay)
[63.079886] Starting subtest: zero-hdisplay
[63.082442] Starting dynamic subtest: pipe-A-eDP-1
[63.366490] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.287s)
[63.373828] Starting dynamic subtest: pipe-B-eDP-1
[63.376152] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[63.382928] Starting dynamic subtest: pipe-C-eDP-1
[63.385221] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[63.392836] Starting dynamic subtest: pipe-D-eDP-1
[63.395244] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[63.397557] Subtest zero-hdisplay: SUCCESS (0.291s)
[64.202320] [007/133] (953s left) kms_psr (fbc-pr-primary-mmap-gtt)
[64.287876] Starting subtest: fbc-pr-primary-mmap-gtt
[64.292283] Subtest fbc-pr-primary-mmap-gtt: SKIP (0.000s)
[64.357601] [008/133] (953s left) kms_cursor_legacy (short-busy-flip-before-cursor-atomic-transitions)
[64.490972] Starting subtest: short-busy-flip-before-cursor-atomic-transitions
[64.495702] Subtest short-busy-flip-before-cursor-atomic-transitions: SKIP (0.000s)
[64.648183] [009/133] (953s left) gem_exec_schedule (preempt)
[64.718562] Starting subtest: preempt
[64.720793] Starting dynamic subtest: rcs0
[64.736389] Dynamic subtest rcs0: SUCCESS (0.024s)
[64.743639] Starting dynamic subtest: bcs0
[64.754665] Dynamic subtest bcs0: SUCCESS (0.018s)
[64.761939] Starting dynamic subtest: vcs0
[64.778279] Dynamic subtest vcs0: SUCCESS (0.023s)
[64.785263] Starting dynamic subtest: vcs1
[64.799122] Dynamic subtest vcs1: SUCCESS (0.020s)
[64.807999] Starting dynamic subtest: vecs0
[64.825561] Dynamic subtest vecs0: SUCCESS (0.026s)
[64.832877] Starting dynamic subtest: ccs0
[64.845174] Dynamic subtest ccs0: SUCCESS (0.019s)
[64.847328] Subtest preempt: SUCCESS (0.133s)
[66.028681] [010/133] (951s left) kms_flip_scaled_crc (flip-64bpp-xtile-to-32bpp-xtile-upscaling)
[66.126165] Starting subtest: flip-64bpp-xtile-to-32bpp-xtile-upscaling
[66.128496] Starting dynamic subtest: pipe-A-default-mode
[68.865142] Dynamic subtest pipe-A-default-mode: SUCCESS (2.739s)
[68.867445] Subtest flip-64bpp-xtile-to-32bpp-xtile-upscaling: SUCCESS (2.741s)
[69.695378] [011/133] (948s left) kms_psr2_su (page_flip-nv12)
[69.755080] Subtest page_flip-NV12: SKIP (0.000s)
[69.815797] [012/133] (948s left) kms_rotation_crc (primary-rotation-270)
[69.911124] Starting subtest: primary-rotation-270
[69.915315] Subtest primary-rotation-270: SKIP (0.001s)
[70.001394] [013/133] (947s left) kms_cursor_edge_walk (256x256-left-edge)
[70.092682] Starting subtest: 256x256-left-edge
[70.094996] Starting dynamic subtest: pipe-A-eDP-1
[73.571911] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.481s)
[73.579852] Starting dynamic subtest: pipe-D-eDP-1
[76.689297] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.117s)
[76.691182] Subtest 256x256-left-edge: SUCCESS (6.600s)
[77.493768] [014/133] (940s left) gem_mmap_gtt (cpuset-big-copy-xy)
[77.548705] Subtest cpuset-big-copy-XY: SKIP (0.000s)
[77.612916] [015/133] (940s left) gem_exec_reloc (basic-gtt)
[77.678561] Subtest basic-gtt: SKIP (0.000s)
[77.730575] [016/133] (940s left) kms_feature_discovery (psr2)
[77.835814] Starting subtest: psr2
[77.838113] Subtest psr2: SUCCESS (0.000s)
[77.947211] [017/133] (940s left) kms_feature_discovery (chamelium)
[78.036067] Starting subtest: chamelium
[78.040379] Subtest chamelium: SKIP (0.000s)
[78.105098] [018/133] (939s left) gem_exec_params (sol-reset-not-gen7)
[78.159063] Starting subtest: sol-reset-not-gen7
[78.163761] Subtest sol-reset-not-gen7: SUCCESS (0.005s)
[78.268053] [019/133] (939s left) kms_content_protection (suspend-resume)
[78.400322] Starting subtest: suspend-resume
[78.404966] Subtest suspend-resume: SKIP (0.000s)
[78.514049] [020/133] (939s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-pwrite)
[78.617894] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-pwrite
[78.621733] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[78.707835] [021/133] (939s left) kms_flip (2x-blocking-wf_vblank)
[78.804369] Starting subtest: 2x-blocking-wf_vblank
[78.813459] Subtest 2x-blocking-wf_vblank: SKIP (0.011s)
[78.927863] [022/133] (939s left) gem_pread (display)
[78.995521] Subtest display: SKIP (0.000s)
[79.060750] [023/133] (939s left) kms_plane_scaling (plane-scaler-with-clipping-clamping-rotation)
[79.142173] Starting subtest: plane-scaler-with-clipping-clamping-rotation
[79.144314] Starting dynamic subtest: pipe-A
[79.384264] Dynamic subtest pipe-A: SUCCESS (0.242s)
[79.392288] Starting dynamic subtest: pipe-B
[80.677247] Dynamic subtest pipe-B: SUCCESS (1.293s)
[80.684537] Starting dynamic subtest: pipe-C
[82.004382] Dynamic subtest pipe-C: SUCCESS (1.327s)
[82.011733] Starting dynamic subtest: pipe-D
[83.338142] Dynamic subtest pipe-D: SUCCESS (1.334s)
[83.340421] Subtest plane-scaler-with-clipping-clamping-rotation: SUCCESS (4.197s)
[84.515066] [024/133] (933s left) gem_render_copy (mixed-tiled-to-yf-tiled-ccs)
[84.580067] Starting subtest: mixed-tiled-to-yf-tiled-ccs
[84.584580] Subtest mixed-tiled-to-yf-tiled-ccs: SKIP (0.000s)
[84.771910] [025/133] (933s left) prime_vgem (fence-wait)
[84.859879] Starting subtest: fence-wait
[84.862298] Starting dynamic subtest: rcs0
[85.904233] Dynamic subtest rcs0: SUCCESS (1.043s)
[85.912270] Starting dynamic subtest: bcs0
[86.954973] Dynamic subtest bcs0: SUCCESS (1.049s)
[86.965259] Starting dynamic subtest: vcs0
[88.001529] Dynamic subtest vcs0: SUCCESS (1.045s)
[88.011954] Starting dynamic subtest: vcs1
[89.042513] Dynamic subtest vcs1: SUCCESS (1.040s)
[89.054677] Starting dynamic subtest: vecs0
[90.086840] Dynamic subtest vecs0: SUCCESS (1.043s)
[90.097037] Starting dynamic subtest: ccs0
[91.130801] Dynamic subtest ccs0: SUCCESS (1.043s)
[91.133367] Subtest fence-wait: SUCCESS (6.272s)
[91.244709] [026/133] (927s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-mmap-wc)
[91.345727] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-mmap-wc
[98.028221] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-mmap-wc: SUCCESS (6.686s)
[98.176754] [027/133] (920s left) api_intel_allocator (gem-pool)
[98.236415] Starting subtest: gem-pool
[98.241727] Subtest gem-pool: SUCCESS (0.008s)
[98.384641] [028/133] (920s left) i915_pm_rps (reset)
[98.450592] Starting subtest: reset
[106.909635] Subtest reset: SUCCESS (8.456s)
[107.025827] [029/133] (911s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-mmap-wc)
[107.124689] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-mmap-wc
[107.128755] Subtest fbc-2p-scndscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[107.255219] [030/133] (911s left) syncobj_timeline (multi-wait-for-submit-unsubmitted-signaled)
[107.322047] Starting subtest: multi-wait-for-submit-unsubmitted-signaled
[107.324343] Subtest multi-wait-for-submit-unsubmitted-signaled: SUCCESS (0.001s)
[107.427827] [031/133] (911s left) vgem_basic (dmabuf-mmap)
[107.470195] Starting subtest: dmabuf-mmap
[107.503298] Subtest dmabuf-mmap: SUCCESS (0.035s)
[107.560941] [032/133] (911s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-mmap-cpu)
[107.670318] Starting subtest: psr-2p-primscrn-pri-indfb-draw-mmap-cpu
[107.674234] Subtest psr-2p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[107.755810] [033/133] (910s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-shrfb-msflip-blt)
[107.851270] Starting subtest: fbcpsr-2p-primscrn-shrfb-msflip-blt
[107.855595] Subtest fbcpsr-2p-primscrn-shrfb-msflip-blt: SKIP (0.000s)
[107.930153] [034/133] (910s left) kms_ccs (crc-primary-suspend-4-tiled-bmg-ccs)
[108.016185] Starting subtest: crc-primary-suspend-4-tiled-bmg-ccs
[108.019952] Subtest crc-primary-suspend-4-tiled-bmg-ccs: SKIP (0.000s)
[109.173267] [035/133] (909s left) kms_flip (2x-dpms-vs-vblank-race)
[109.270628] Starting subtest: 2x-dpms-vs-vblank-race
[109.280750] Subtest 2x-dpms-vs-vblank-race: SKIP (0.011s)
[109.362965] [036/133] (909s left) kms_ccs (bad-pixel-format-4-tiled-mtl-rc-ccs-cc)
[109.460106] Starting subtest: bad-pixel-format-4-tiled-mtl-rc-ccs-cc
[109.462368] Starting dynamic subtest: pipe-A-eDP-1
[109.483043] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s)
[109.493839] Starting dynamic subtest: pipe-B-eDP-1
[109.512783] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[109.520057] Starting dynamic subtest: pipe-C-eDP-1
[109.539403] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[109.546409] Starting dynamic subtest: pipe-D-eDP-1
[109.565798] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[109.567668] Subtest bad-pixel-format-4-tiled-mtl-rc-ccs-cc: SUCCESS (0.004s)
[111.733411] [037/133] (907s left) perf_pmu (invalid-open)
[111.780544] Starting subtest: invalid-open
[111.782867] Subtest invalid-open: SUCCESS (0.000s)
[111.903130] [038/133] (907s left) gem_spin_batch (engines)
[111.963398] Starting subtest: engines
[111.965740] Starting dynamic subtest: rcs0
[115.204704] Dynamic subtest rcs0: SUCCESS (3.235s)
[115.215393] Starting dynamic subtest: bcs0
[118.492777] Dynamic subtest bcs0: SUCCESS (3.234s)
[118.505841] Starting dynamic subtest: vcs0
[121.728165] Dynamic subtest vcs0: SUCCESS (3.234s)
[121.739063] Starting dynamic subtest: vcs1
[124.967905] Dynamic subtest vcs1: SUCCESS (3.236s)
[124.979531] Starting dynamic subtest: vecs0
[128.203653] Dynamic subtest vecs0: SUCCESS (3.234s)
[128.216975] Starting dynamic subtest: ccs0
[131.441770] Dynamic subtest ccs0: SUCCESS (3.235s)
[131.444220] Subtest engines: SUCCESS (19.418s)
[131.620900] [039/133] (887s left) kms_color_pipeline (plane-lut1d-ctm3x4-lut1d)
[131.737695] Starting subtest: plane-lut1d-ctm3x4-lut1d
[131.917170] Starting dynamic subtest: pipe-A-plane-0
[132.075077] Dynamic subtest pipe-A-plane-0: SUCCESS (0.156s)
[132.082824] Starting dynamic subtest: pipe-A-plane-1
[132.230551] Dynamic subtest pipe-A-plane-1: SUCCESS (0.155s)
[132.238944] Starting dynamic subtest: pipe-A-plane-2
[132.405744] Dynamic subtest pipe-A-plane-2: SUCCESS (0.177s)
[133.621108] Starting dynamic subtest: pipe-B-plane-0
[133.792719] Dynamic subtest pipe-B-plane-0: SUCCESS (0.178s)
[133.804061] Starting dynamic subtest: pipe-B-plane-1
[133.981520] Dynamic subtest pipe-B-plane-1: SUCCESS (0.188s)
[133.989555] Starting dynamic subtest: pipe-B-plane-2
[134.148437] Dynamic subtest pipe-B-plane-2: SUCCESS (0.166s)
[135.351599] Starting dynamic subtest: pipe-C-plane-0
[135.500822] Dynamic subtest pipe-C-plane-0: SUCCESS (0.155s)
[135.509833] Starting dynamic subtest: pipe-C-plane-1
[135.667089] Dynamic subtest pipe-C-plane-1: SUCCESS (0.166s)
[135.675550] Starting dynamic subtest: pipe-C-plane-2
[135.834119] Dynamic subtest pipe-C-plane-2: SUCCESS (0.166s)
[137.070693] Starting dynamic subtest: pipe-D-plane-0
[137.229755] Dynamic subtest pipe-D-plane-0: SUCCESS (0.166s)
[137.237671] Starting dynamic subtest: pipe-D-plane-1
[137.396768] Dynamic subtest pipe-D-plane-1: SUCCESS (0.166s)
[137.404478] Starting dynamic subtest: pipe-D-plane-2
[137.563649] Dynamic subtest pipe-D-plane-2: SUCCESS (0.166s)
[137.861761] Subtest plane-lut1d-ctm3x4-lut1d: SUCCESS (6.125s)
[138.737201] [040/133] (880s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-blt)
[138.838188] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-blt
[138.842148] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-blt: SKIP (0.000s)
[138.935877] [041/133] (880s left) gem_ctx_persistence (hang)
[138.997860] Starting subtest: hang
[139.002270] Subtest hang: SKIP (0.000s)
[139.097744] [042/133] (880s left) gem_barrier_race (remote-request)
[139.158611] Starting subtest: remote-request
[139.161047] Starting dynamic subtest: rcs0
[144.368455] Dynamic subtest rcs0: SUCCESS (5.207s)
[144.370140] Subtest remote-request: SUCCESS (5.208s)
[144.522755] [043/133] (874s left) gem_mmap_wc (pf-nonblock)
[144.584227] Subtest pf-nonblock: SKIP (0.000s)
[144.642785] [044/133] (874s left) kms_cursor_legacy (flip-vs-cursor-toggle)
[144.761210] Starting subtest: flip-vs-cursor-toggle
[153.884103] Subtest flip-vs-cursor-toggle: SUCCESS (9.122s)
[154.685031] [045/133] (864s left) kms_chamelium_edid (hdmi-edid-change-during-suspend)
[155.074662] Subtest hdmi-edid-change-during-suspend: SKIP (0.000s)
[155.895157] [046/133] (863s left) kms_big_fb (linear-max-hw-stride-32bpp-rotate-0)
[155.995694] Starting subtest: linear-max-hw-stride-32bpp-rotate-0
[157.140678] Subtest linear-max-hw-stride-32bpp-rotate-0: SUCCESS (1.145s)
[157.260309] [047/133] (862s left) perf (mi-rpc)
[157.351600] Starting subtest: mi-rpc
[157.355443] Subtest mi-rpc: SKIP (0.000s)
[157.392320] [048/133] (861s left) i915_getparams_basic (basic-subslice-total)
[157.433467] Starting subtest: basic-subslice-total
[157.437103] Subtest basic-subslice-total: SUCCESS (0.000s)
[157.511839] [049/133] (861s left) gem_render_copy (y-tiled-mc-ccs-to-vebox-y-tiled)
[157.560320] Starting subtest: y-tiled-mc-ccs-to-vebox-y-tiled
[157.564030] Subtest y-tiled-mc-ccs-to-vebox-y-tiled: SKIP (0.000s)
[157.740771] [050/133] (861s left) gem_exec_whisper (basic-queues-priority-all)
[157.822649] Starting subtest: basic-queues-priority-all
[180.232775] Subtest basic-queues-priority-all: SUCCESS (22.405s)
[180.450569] [051/133] (839s left) kms_pipe_b_c_ivb (enable-pipe-c-while-b-has-3-lanes)
[180.506198] Subtest enable-pipe-C-while-B-has-3-lanes: SKIP (0.000s)
[180.573240] [052/133] (838s left) gem_userptr_blits (forbidden-operations)
[180.631565] Starting subtest: forbidden-operations
[180.636668] Subtest forbidden-operations: SKIP (0.000s)
[180.769699] [053/133] (838s left) kms_cursor_legacy (cursor-vs-flip-atomic-transitions)
[180.888961] Starting subtest: cursor-vs-flip-atomic-transitions
[211.177456] Subtest cursor-vs-flip-atomic-transitions: SUCCESS (30.285s)
[212.054346] [054/133] (807s left) gem_exec_flush (basic-wb-rw-default)
[212.122721] Starting subtest: basic-wb-rw-default
[217.602840] Subtest basic-wb-rw-default: SUCCESS (5.455s)
[217.775171] [055/133] (801s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-0-hflip)
[217.884174] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-0-hflip
[217.888604] Subtest yf-tiled-max-hw-stride-64bpp-rotate-0-hflip: SKIP (0.000s)
[217.991623] [056/133] (801s left) kms_async_flips (test-time-stamp)
[218.088161] Starting subtest: test-time-stamp
[218.471470] Starting dynamic subtest: pipe-A-eDP-1
[219.237402] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.765s)
[219.615692] Starting dynamic subtest: pipe-B-eDP-1
[220.375079] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.764s)
[220.764455] Starting dynamic subtest: pipe-C-eDP-1
[221.525299] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.765s)
[221.890474] Starting dynamic subtest: pipe-D-eDP-1
[222.653532] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.768s)
[222.656063] Subtest test-time-stamp: SUCCESS (4.565s)
[223.823193] [057/133] (795s left) gem_wait (wait)
[223.885788] Starting subtest: wait
[223.888082] Starting dynamic subtest: all-engines
[225.878465] Dynamic subtest all-engines: SUCCESS (1.990s)
[225.890190] Starting dynamic subtest: rcs0
[226.925771] Dynamic subtest rcs0: SUCCESS (1.046s)
[226.937120] Starting dynamic subtest: bcs0
[227.973195] Dynamic subtest bcs0: SUCCESS (1.046s)
[227.984560] Starting dynamic subtest: vcs0
[229.019393] Dynamic subtest vcs0: SUCCESS (1.043s)
[229.030647] Starting dynamic subtest: vcs1
[230.066476] Dynamic subtest vcs1: SUCCESS (1.045s)
[230.077923] Starting dynamic subtest: vecs0
[231.112499] Dynamic subtest vecs0: SUCCESS (1.044s)
[231.123665] Starting dynamic subtest: ccs0
[232.161667] Dynamic subtest ccs0: SUCCESS (1.047s)
[232.164147] Subtest wait: SUCCESS (8.276s)
[232.360982] [058/133] (787s left) syncobj_wait (multi-wait-all-for-submit-unsubmitted-submitted)
[232.419432] Starting subtest: multi-wait-all-for-submit-unsubmitted-submitted
[232.522219] Subtest multi-wait-all-for-submit-unsubmitted-submitted: SUCCESS (0.102s)
[232.600384] [059/133] (787s left) kms_pm_rpm (dpms-lpsp)
[234.129949] Starting subtest: dpms-lpsp
[234.777069] Subtest dpms-lpsp: SUCCESS (0.650s)
[234.879900] [060/133] (784s left) gem_exec_fence (syncobj-timeline-repeat)
[235.417403] Starting subtest: syncobj-timeline-repeat
[235.651702] Subtest syncobj-timeline-repeat: SUCCESS (0.234s)
[236.963808] [061/133] (782s left) kms_psr (fbc-psr-dpms)
[237.062461] Starting subtest: fbc-psr-dpms
[237.064712] Starting dynamic subtest: eDP-1
[237.069161] Dynamic subtest eDP-1: SKIP (0.000s)
[237.073619] Subtest fbc-psr-dpms: SKIP (0.001s)
[237.136975] [062/133] (782s left) kms_setmode (invalid-clone-single-crtc)
[237.197657] Starting subtest: invalid-clone-single-crtc
[237.204196] Subtest invalid-clone-single-crtc: SKIP (0.000s)
[237.296890] [063/133] (782s left) gem_mmap_offset (clear-via-pagefault)
[237.349084] Starting subtest: clear-via-pagefault
[237.350970] Starting dynamic subtest: smem0
[273.278947] Dynamic subtest smem0: SUCCESS (35.927s)
[273.281079] Subtest clear-via-pagefault: SUCCESS (35.928s)
[273.382071] [064/133] (746s left) kms_atomic_interruptible (universal-setplane-cursor)
[273.482375] Starting subtest: universal-setplane-cursor
[273.484701] Starting dynamic subtest: pipe-A-eDP-1
[280.856713] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.375s)
[280.858869] Subtest universal-setplane-cursor: SUCCESS (7.377s)
[281.701998] [065/133] (738s left) gem_exec_balancer (parallel-contexts)
[281.958262] Starting subtest: parallel-contexts
[285.251998] Subtest parallel-contexts: SUCCESS (3.294s)
[286.097889] [066/133] (733s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-shrfb-plflip-blt)
[286.196339] Starting subtest: fbcpsr-2p-scndscrn-shrfb-plflip-blt
[286.200642] Subtest fbcpsr-2p-scndscrn-shrfb-plflip-blt: SKIP (0.000s)
[286.281794] [067/133] (733s left) gem_eio (context-create)
[286.490619] Starting subtest: context-create
[286.802554] Subtest context-create: SUCCESS (0.311s)
[286.931816] [068/133] (733s left) kms_big_fb (y-tiled-8bpp-rotate-90)
[287.028815] Starting subtest: y-tiled-8bpp-rotate-90
[287.033251] Subtest y-tiled-8bpp-rotate-90: SKIP (0.000s)
[287.123802] [069/133] (733s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-0-hflip)
[287.217445] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-0-hflip
[288.263727] Subtest 4-tiled-max-hw-stride-32bpp-rotate-0-hflip: SUCCESS (1.046s)
[288.386199] [070/133] (731s left) kms_vblank (ts-continuation-dpms-suspend)
[288.479109] Starting subtest: ts-continuation-dpms-suspend
[288.480831] Starting dynamic subtest: pipe-A-eDP-1
[306.024756] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.964s)
[306.038915] Starting dynamic subtest: pipe-D-eDP-1
[324.021312] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.516s)
[324.023737] Subtest ts-continuation-dpms-suspend: SUCCESS (4.484s)
[324.839685] [071/133] (695s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-mmap-wc)
[324.942359] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-mmap-wc
[329.214031] Subtest fbc-1p-primscrn-pri-indfb-draw-mmap-wc: SUCCESS (4.282s)
[330.445134] [072/133] (689s left) vgem_basic (dmabuf-export)
[330.493471] Starting subtest: dmabuf-export
[330.520865] Subtest dmabuf-export: SUCCESS (0.032s)
[330.628256] [073/133] (689s left) kms_psr2_sf (pr-cursor-plane-move-continuous-exceed-fully-sf)
[330.722746] Starting subtest: pr-cursor-plane-move-continuous-exceed-fully-sf
[330.726812] Subtest pr-cursor-plane-move-continuous-exceed-fully-sf: SKIP (0.000s)
[330.809419] [074/133] (689s left) drm_read (empty-block)
[330.965025] Starting subtest: empty-block
[331.964711] Subtest empty-block: SUCCESS (1.001s)
[332.086841] [075/133] (688s left) syncobj_wait (reset-during-wait-for-submit)
[332.149921] Starting subtest: reset-during-wait-for-submit
[332.252362] Subtest reset-during-wait-for-submit: SUCCESS (0.103s)
[332.344686] [076/133] (688s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip)
[332.437688] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip
[333.061360] Subtest x-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip: SUCCESS (0.626s)
[333.220770] [077/133] (687s left) gem_exec_balancer (full)
[333.275672] Starting subtest: full
[337.796570] Subtest full: SUCCESS (4.523s)
[338.120230] [078/133] (682s left) kms_frontbuffer_tracking (psr-indfb-scaledprimary)
[338.218860] Starting subtest: psr-indfb-scaledprimary
[343.975718] Subtest psr-indfb-scaledprimary: SUCCESS (5.762s)
[344.102574] [079/133] (676s left) gem_exec_schedule (semaphore-codependency)
[344.182844] Starting subtest: semaphore-codependency
[344.188590] Subtest semaphore-codependency: SUCCESS (0.013s)
[344.533915] [080/133] (676s left) syncobj_timeline (wait-all-complex)
[344.586393] Starting subtest: wait-all-complex
[344.801921] Subtest wait-all-complex: SUCCESS (0.214s)
[344.878277] [081/133] (675s left) kms_ccs (bad-rotation-90-y-tiled-gen12-rc-ccs)
[344.961737] Starting subtest: bad-rotation-90-y-tiled-gen12-rc-ccs
[344.964085] Starting dynamic subtest: pipe-A-eDP-1
[344.987419] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[344.998951] Starting dynamic subtest: pipe-B-eDP-1
[345.021111] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[345.030578] Starting dynamic subtest: pipe-C-eDP-1
[345.052444] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[345.061665] Starting dynamic subtest: pipe-D-eDP-1
[345.083745] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[345.087815] Subtest bad-rotation-90-y-tiled-gen12-rc-ccs: SKIP (0.005s)
[347.229632] [082/133] (673s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-180-async-flip)
[347.329518] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-180-async-flip
[348.120316] Subtest 4-tiled-max-hw-stride-64bpp-rotate-180-async-flip: SUCCESS (0.792s)
[348.271678] [083/133] (672s left) kms_plane (pixel-format-4-tiled-dg2-rc-ccs-modifier-source-clamping)
[348.366435] Starting subtest: pixel-format-4-tiled-dg2-rc-ccs-modifier-source-clamping
[348.370500] Subtest pixel-format-4-tiled-dg2-rc-ccs-modifier-source-clamping: SKIP (0.000s)
[348.452412] [084/133] (672s left) gem_create (create-ext-placement-all)
[348.630210] Starting subtest: create-ext-placement-all
[348.632199] Subtest create-ext-placement-all: SUCCESS (0.000s)
[348.730669] [085/133] (672s left) kms_cursor_legacy (long-nonblocking-modeset-vs-cursor-atomic)
[348.847850] Starting subtest: long-nonblocking-modeset-vs-cursor-atomic
[366.662280] Subtest long-nonblocking-modeset-vs-cursor-atomic: SUCCESS (17.814s)
[367.543923] [086/133] (653s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-mmap-cpu)
[367.648899] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-mmap-cpu
[367.653278] Subtest fbc-2p-scndscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[367.743143] [087/133] (653s left) gen7_exec_parse (bitmasks)
[367.809362] Subtest bitmasks: SKIP (0.000s)
[367.856832] [088/133] (653s left) gem_eio (in-flight-contexts-1us)
[368.081075] Starting subtest: in-flight-contexts-1us
[382.012501] Subtest in-flight-contexts-1us: SUCCESS (13.934s)
[382.191854] [089/133] (638s left) gem_exec_suspend (basic-s3-devices)
[382.258098] Starting subtest: basic-S3-devices
[382.260408] Starting dynamic subtest: smem
[393.967363] Dynamic subtest smem: SUCCESS (11.709s)
[393.970266] Subtest basic-S3-devices: SUCCESS (11.712s)
[394.150258] [090/133] (626s left) gem_exec_params (invalid-ring2)
[394.222439] Starting subtest: invalid-ring2
[394.224806] Subtest invalid-ring2: SUCCESS (0.000s)
[394.327968] [091/133] (626s left) i915_query (test-query-geometry-subslices)
[394.384073] Starting subtest: test-query-geometry-subslices
[394.386361] Subtest test-query-geometry-subslices: SUCCESS (0.000s)
[394.491662] [092/133] (626s left) kms_universal_plane (disable-primary-vs-flip)
[394.585243] Starting subtest: disable-primary-vs-flip
[394.588104] Starting dynamic subtest: pipe-A-eDP-1
[396.159799] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.572s)
[396.169929] Starting dynamic subtest: pipe-B-eDP-1
[398.390381] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.231s)
[398.400825] Starting dynamic subtest: pipe-C-eDP-1
[400.563191] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.170s)
[400.573761] Starting dynamic subtest: pipe-D-eDP-1
[402.748080] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.185s)
[402.750345] Subtest disable-primary-vs-flip: SUCCESS (8.164s)
[403.555142] [093/133] (617s left) kms_vrr (seamless-rr-switch-drrs)
[403.657409] Starting subtest: seamless-rr-switch-drrs
[403.663709] Subtest seamless-rr-switch-drrs: SKIP (0.000s)
[403.746216] [094/133] (617s left) gem_exec_params (dr4-dirt)
[403.801062] Starting subtest: DR4-dirt
[403.803446] Subtest DR4-dirt: SUCCESS (0.000s)
[403.904630] [095/133] (617s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-mmap-cpu)
[404.002750] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-mmap-cpu
[404.007131] Subtest fbc-2p-scndscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[404.104705] [096/133] (617s left) kms_plane_scaling (plane-scaler-unity-scaling-with-rotation)
[404.202351] Starting subtest: plane-scaler-unity-scaling-with-rotation
[404.204277] Starting dynamic subtest: pipe-A
[404.428884] Dynamic subtest pipe-A: SUCCESS (0.229s)
[404.438512] Starting dynamic subtest: pipe-B
[405.718764] Dynamic subtest pipe-B: SUCCESS (1.289s)
[405.728329] Starting dynamic subtest: pipe-C
[407.049860] Dynamic subtest pipe-C: SUCCESS (1.330s)
[407.067901] Starting dynamic subtest: pipe-D
[408.368330] Dynamic subtest pipe-D: SUCCESS (1.317s)
[408.370509] Subtest plane-scaler-unity-scaling-with-rotation: SUCCESS (4.170s)
[409.547640] [097/133] (611s left) i915_drm_fdinfo (context-close-stress)
[409.593899] Starting subtest: context-close-stress
[420.351855] Subtest context-close-stress: SUCCESS (10.746s)
[420.419162] [098/133] (601s left) kms_chamelium_hpd (dp-hpd-storm)
[421.010357] Subtest dp-hpd-storm: SKIP (0.000s)
[421.883672] [099/133] (599s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-wc)
[421.977200] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-wc
[429.087204] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-wc: SUCCESS (7.115s)
[429.217844] [100/133] (592s left) syncobj_timeline (etime-multi-wait-for-submit-submitted)
[429.268385] Starting subtest: etime-multi-wait-for-submit-submitted
[429.370329] Subtest etime-multi-wait-for-submit-submitted: SUCCESS (0.102s)
[429.448628] [101/133] (592s left) perf_pmu (all-busy-idle-check-all)
[429.487198] Starting subtest: all-busy-idle-check-all
[430.960110] Subtest all-busy-idle-check-all: SUCCESS (1.473s)
[431.063929] [102/133] (590s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-blt)
[431.173377] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-blt
[438.554427] Subtest psr-1p-primscrn-pri-shrfb-draw-blt: SUCCESS (7.385s)
[438.682306] [103/133] (583s left) kms_frontbuffer_tracking (psr-1p-primscrn-shrfb-msflip-blt)
[438.782636] Starting subtest: psr-1p-primscrn-shrfb-msflip-blt
[446.145311] Subtest psr-1p-primscrn-shrfb-msflip-blt: SUCCESS (7.367s)
[446.272400] [104/133] (575s left) kms_joiner (switch-modeset-ultra-joiner-big-joiner)
[446.372549] Starting subtest: switch-modeset-ultra-joiner-big-joiner
[446.376659] Subtest switch-modeset-ultra-joiner-big-joiner: SKIP (0.000s)
[446.441260] [105/133] (575s left) kms_cursor_crc (cursor-offscreen-256x256)
[446.686076] Starting subtest: cursor-offscreen-256x256
[446.688470] Starting dynamic subtest: pipe-A-eDP-1
[448.627546] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.937s)
[448.659074] Starting dynamic subtest: pipe-D-eDP-1
[451.217844] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.567s)
[451.219758] Subtest cursor-offscreen-256x256: SUCCESS (4.532s)
[452.071518] [106/133] (569s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-mmap-cpu)
[452.172789] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-mmap-cpu
[452.177253] Subtest fbc-2p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[452.273228] [107/133] (569s left) kms_async_flips (alternate-sync-async-flip-atomic)
[452.372567] Starting subtest: alternate-sync-async-flip-atomic
[452.744626] Starting dynamic subtest: pipe-A-eDP-1
[455.553716] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.811s)
[455.942310] Starting dynamic subtest: pipe-B-eDP-1
[458.683085] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.749s)
[459.047471] Starting dynamic subtest: pipe-C-eDP-1
[461.809249] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.771s)
[462.184619] Starting dynamic subtest: pipe-D-eDP-1
[464.950216] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.774s)
[464.952347] Subtest alternate-sync-async-flip-atomic: SUCCESS (12.585s)
[466.137002] [108/133] (555s left) syncobj_eventfd (invalid-bad-flags)
[466.198325] Starting subtest: invalid-bad-flags
[466.200588] Subtest invalid-bad-flags: SUCCESS (0.000s)
[466.294897] [109/133] (555s left) kms_ccs (bad-aux-stride-4-tiled-mtl-rc-ccs-cc)
[466.386370] Starting subtest: bad-aux-stride-4-tiled-mtl-rc-ccs-cc
[466.388505] Starting dynamic subtest: pipe-A-eDP-1
[466.408166] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.002s)
[466.419351] Starting dynamic subtest: pipe-B-eDP-1
[466.437558] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.002s)
[466.446773] Starting dynamic subtest: pipe-C-eDP-1
[466.465429] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.002s)
[466.476331] Starting dynamic subtest: pipe-D-eDP-1
[466.495523] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.002s)
[466.497400] Subtest bad-aux-stride-4-tiled-mtl-rc-ccs-cc: SUCCESS (0.016s)
[468.707548] [110/133] (553s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-render)
[468.797188] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-render
[468.801387] Subtest psr-2p-scndscrn-cur-indfb-draw-render: SKIP (0.000s)
[468.896753] [111/133] (553s left) kms_getfb (getfb-reject-nv12)
[468.991322] Starting subtest: getfb-reject-nv12
[468.993415] Subtest getfb-reject-nv12: SUCCESS (0.002s)
[469.088588] [112/133] (552s left) kms_chamelium_color (ctm-blue-to-red)
[469.182173] Subtest ctm-blue-to-red: SKIP (0.000s)
[469.230734] [113/133] (552s left) syncobj_timeline (multi-wait-all-available-submitted-signaled)
[469.283251] Starting subtest: multi-wait-all-available-submitted-signaled
[469.285552] Subtest multi-wait-all-available-submitted-signaled: SUCCESS (0.000s)
[469.375722] [114/133] (552s left) gem_caching (writes)
[469.439149] Subtest writes: SKIP (0.000s)
[469.511066] [115/133] (552s left) kms_psr (psr-suspend)
[469.604323] Starting subtest: psr-suspend
[469.606558] Starting dynamic subtest: eDP-1
[487.917246] Dynamic subtest eDP-1: SUCCESS (2.873s)
[487.919720] Subtest psr-suspend: SUCCESS (2.874s)
[488.775688] [116/133] (533s left) kms_psr (psr2-cursor-blt)
[488.872870] Starting subtest: psr2-cursor-blt
[488.875159] Starting dynamic subtest: eDP-1
[490.580351] Dynamic subtest eDP-1: SUCCESS (1.707s)
[490.583400] Subtest psr2-cursor-blt: SUCCESS (1.708s)
[491.449298] [117/133] (530s left) kms_psr (psr-basic)
[491.549394] Starting subtest: psr-basic
[491.552165] Starting dynamic subtest: eDP-1
[493.137335] Dynamic subtest eDP-1: SUCCESS (1.587s)
[493.140210] Subtest psr-basic: SUCCESS (1.589s)
[494.028556] [118/133] (528s left) gem_exec_reloc (basic-write-gtt)
[494.080727] Subtest basic-write-gtt: SKIP (0.000s)
[494.147186] [119/133] (528s left) kms_flip (2x-flip-vs-fences)
[494.240758] Starting subtest: 2x-flip-vs-fences
[494.245331] Subtest 2x-flip-vs-fences: SKIP (0.000s)
[494.342505] [120/133] (528s left) kms_atomic_transition (plane-all-transition)
[494.438527] Starting subtest: plane-all-transition
[494.440732] Starting dynamic subtest: pipe-A-eDP-1
[496.931890] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.495s)
[497.241950] Starting dynamic subtest: pipe-B-eDP-1
[500.444644] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.219s)
[500.742878] Subtest plane-all-transition: SUCCESS (6.312s)
[501.571830] [121/133] (520s left) gem_ctx_persistence (engines-hostile)
[501.650234] Starting subtest: engines-hostile
[501.653310] Starting dynamic subtest: rcs0
[501.717821] Dynamic subtest rcs0: SUCCESS (0.067s)
[501.732015] Starting dynamic subtest: bcs0
[501.807657] Dynamic subtest bcs0: SUCCESS (0.088s)
[501.819923] Starting dynamic subtest: vcs0
[501.900053] Dynamic subtest vcs0: SUCCESS (0.090s)
[501.911650] Starting dynamic subtest: vcs1
[501.990456] Dynamic subtest vcs1: SUCCESS (0.088s)
[502.002825] Starting dynamic subtest: vecs0
[502.091711] Dynamic subtest vecs0: SUCCESS (0.099s)
[502.106431] Starting dynamic subtest: ccs0
[502.183692] Dynamic subtest ccs0: SUCCESS (0.090s)
[502.186668] Subtest engines-hostile: SUCCESS (0.536s)
[502.264672] [122/133] (520s left) kms_plane_cursor (primary)
[502.353207] Starting subtest: primary
[502.358077] Starting dynamic subtest: pipe-A-eDP-1-size-64
[504.956304] Dynamic subtest pipe-A-eDP-1-size-64: SUCCESS (2.609s)
[504.981352] Starting dynamic subtest: pipe-A-eDP-1-size-128
[507.576210] Dynamic subtest pipe-A-eDP-1-size-128: SUCCESS (2.605s)
[507.600024] Starting dynamic subtest: pipe-A-eDP-1-size-256
[510.227696] Dynamic subtest pipe-A-eDP-1-size-256: SUCCESS (2.638s)
[510.548202] Starting dynamic subtest: pipe-B-eDP-1-size-64
[513.812071] Dynamic subtest pipe-B-eDP-1-size-64: SUCCESS (3.279s)
[513.837476] Starting dynamic subtest: pipe-B-eDP-1-size-128
[516.398822] Dynamic subtest pipe-B-eDP-1-size-128: SUCCESS (2.571s)
[516.423818] Starting dynamic subtest: pipe-B-eDP-1-size-256
[519.043762] Dynamic subtest pipe-B-eDP-1-size-256: SUCCESS (2.627s)
[519.368428] Starting dynamic subtest: pipe-C-eDP-1-size-64
[522.298966] Dynamic subtest pipe-C-eDP-1-size-64: SUCCESS (2.946s)
[522.326030] Starting dynamic subtest: pipe-C-eDP-1-size-128
[524.531853] Dynamic subtest pipe-C-eDP-1-size-128: SUCCESS (2.214s)
[524.558865] Starting dynamic subtest: pipe-C-eDP-1-size-256
[526.774894] Dynamic subtest pipe-C-eDP-1-size-256: SUCCESS (2.225s)
[527.097438] Starting dynamic subtest: pipe-D-eDP-1-size-64
[530.046665] Dynamic subtest pipe-D-eDP-1-size-64: SUCCESS (2.963s)
[530.073860] Starting dynamic subtest: pipe-D-eDP-1-size-128
[532.269443] Dynamic subtest pipe-D-eDP-1-size-128: SUCCESS (2.203s)
[532.296224] Starting dynamic subtest: pipe-D-eDP-1-size-256
[534.527494] Dynamic subtest pipe-D-eDP-1-size-256: SUCCESS (2.236s)
[534.840004] Subtest primary: SUCCESS (32.512s)
[535.671611] [123/133] (486s left) gem_exec_params (no-blt)
[535.735325] Starting subtest: no-blt
[535.737725] Subtest no-blt: SUCCESS (0.005s)
[535.844336] [124/133] (486s left) kms_cursor_crc (cursor-size-hints)
[535.973278] Starting subtest: cursor-size-hints
[535.976146] Starting dynamic subtest: pipe-A-eDP-1
[536.590966] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.615s)
[536.600938] Starting dynamic subtest: pipe-D-eDP-1
[537.835144] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.242s)
[537.837759] Subtest cursor-size-hints: SUCCESS (1.860s)
[538.644863] [125/133] (483s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-16bpp-ytile-upscaling)
[538.741080] Starting subtest: flip-64bpp-ytile-to-16bpp-ytile-upscaling
[538.746222] Subtest flip-64bpp-ytile-to-16bpp-ytile-upscaling: SKIP (0.000s)
[538.817539] [126/133] (483s left) gem_exec_reloc (basic-gtt-wc-noreloc)
[538.889235] Subtest basic-gtt-wc-noreloc: SKIP (0.000s)
[538.962242] [127/133] (483s left) sysfs_timeslice_duration (idempotent)
[539.014561] Starting subtest: idempotent
[539.017221] Starting dynamic subtest: vecs0
[539.020175] Dynamic subtest vecs0: SUCCESS (0.000s)
[539.031252] Starting dynamic subtest: ccs0
[539.033620] Dynamic subtest ccs0: SUCCESS (0.000s)
[539.042809] Starting dynamic subtest: vcs0
[539.045068] Dynamic subtest vcs0: SUCCESS (0.000s)
[539.054462] Starting dynamic subtest: bcs0
[539.057241] Dynamic subtest bcs0: SUCCESS (0.000s)
[539.069046] Starting dynamic subtest: rcs0
[539.071279] Dynamic subtest rcs0: SUCCESS (0.000s)
[539.080390] Starting dynamic subtest: vcs1
[539.082738] Dynamic subtest vcs1: SUCCESS (0.000s)
[539.084985] Subtest idempotent: SUCCESS (0.006s)
[539.123789] [128/133] (483s left) kms_ccs (crc-sprite-planes-basic-4-tiled-mtl-rc-ccs)
[539.223223] Starting subtest: crc-sprite-planes-basic-4-tiled-mtl-rc-ccs
[539.226071] Starting dynamic subtest: pipe-A-eDP-1
[539.755112] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.506s)
[539.765717] Starting dynamic subtest: pipe-B-eDP-1
[541.246299] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.480s)
[541.263832] Starting dynamic subtest: pipe-C-eDP-1
[542.708118] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.463s)
[542.718231] Starting dynamic subtest: pipe-D-eDP-1
[544.146148] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.438s)
[544.148932] Subtest crc-sprite-planes-basic-4-tiled-mtl-rc-ccs: SUCCESS (4.892s)
[545.261847] [129/133] (477s left) api_intel_bb (object-reloc-purge-cache)
[545.324332] Starting subtest: object-reloc-purge-cache
[545.330166] Subtest object-reloc-purge-cache: SKIP (0.003s)
[545.448550] [130/133] (477s left) device_reset (unbind-cold-reset-rebind)
[545.499735] Starting subtest: unbind-cold-reset-rebind
[545.505182] Subtest unbind-cold-reset-rebind: SKIP (0.000s)
[545.575708] [131/133] (477s left) gem_exec_whisper (basic-contexts-forked)
[545.636201] Starting subtest: basic-contexts-forked
[569.035837] Subtest basic-contexts-forked: SUCCESS (23.400s)
[569.221421] [132/133] (453s left) kms_prop_blob (invalid-get-prop)
[569.269677] Starting subtest: invalid-get-prop
[569.272423] Subtest invalid-get-prop: SUCCESS (0.000s)
[569.360907] [133/133] (453s left) kms_pm_rpm (modeset-non-lpsp)
[571.502561] Starting subtest: modeset-non-lpsp
[572.655716] Subtest modeset-non-lpsp: SKIP (1.154s)
[573.038118] 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.