[56.284738] Initializing watchdogs
[56.284798]   /dev/watchdog0
[56.298334] [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.302565] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[56.304798] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[56.307953] [001/133] (960s left) gem_create (create-ext-placement-all)
[56.501101] Starting subtest: create-ext-placement-all
[56.504924] Subtest create-ext-placement-all: SUCCESS (0.000s)
[56.620484] [002/133] (960s left) gem_userptr_blits (map-fixed-invalidate-overlap)
[56.695199] Starting subtest: map-fixed-invalidate-overlap
[56.699440] Subtest map-fixed-invalidate-overlap: SKIP (0.000s)
[56.866326] [003/133] (960s left) gem_pipe_control_store_loop (fresh-buffer)
[56.931698] Starting subtest: fresh-buffer
[59.072766] Subtest fresh-buffer: SUCCESS (2.154s)
[59.221214] [004/133] (957s left) gem_mmap_offset (mmap-boundaries)
[59.291171] Starting subtest: mmap-boundaries
[59.293221] Starting dynamic subtest: smem0
[59.566794] Dynamic subtest smem0: SUCCESS (0.279s)
[59.569275] Subtest mmap-boundaries: SUCCESS (0.279s)
[59.732037] [005/133] (957s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-render)
[59.851754] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-render
[67.130378] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-render: SUCCESS (7.311s)
[67.735718] [006/133] (949s left) kms_atomic (atomic-plane-damage)
[67.934131] Starting subtest: atomic-plane-damage
[68.009115] Starting dynamic subtest: pipe-A-eDP-1
[68.584462] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.573s)
[68.586890] Subtest atomic-plane-damage: SUCCESS (0.650s)
[69.461122] [007/133] (947s left) kms_ccs (bad-aux-stride-4-tiled-mtl-mc-ccs)
[69.547776] Starting subtest: bad-aux-stride-4-tiled-mtl-mc-ccs
[69.550042] Starting dynamic subtest: pipe-A-eDP-1
[69.607751] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.061s)
[69.615739] Starting dynamic subtest: pipe-B-eDP-1
[69.666247] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.058s)
[69.674561] Starting dynamic subtest: pipe-C-eDP-1
[69.727671] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.058s)
[69.736996] Starting dynamic subtest: pipe-D-eDP-1
[69.786584] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.060s)
[69.788866] Subtest bad-aux-stride-4-tiled-mtl-mc-ccs: SUCCESS (0.241s)
[72.025189] [008/133] (945s left) kms_frontbuffer_tracking (psr-rgb101010-draw-mmap-wc)
[72.134970] Starting subtest: psr-rgb101010-draw-mmap-wc
[79.075840] Subtest psr-rgb101010-draw-mmap-wc: SUCCESS (6.948s)
[79.247328] [009/133] (937s left) gem_render_copy (yf-tiled-to-vebox-x-tiled)
[79.304830] Starting subtest: yf-tiled-to-vebox-x-tiled
[79.309376] Subtest yf-tiled-to-vebox-x-tiled: SKIP (0.000s)
[79.510145] [010/133] (937s left) syncobj_timeline (wait-all-complex)
[79.560782] Starting subtest: wait-all-complex
[79.774462] Subtest wait-all-complex: SUCCESS (0.213s)
[79.871396] [011/133] (937s left) gem_pxp (create-valid-protected-context)
[79.997983] Starting subtest: create-valid-protected-context
[80.000435] Subtest create-valid-protected-context: SUCCESS (0.002s)
[80.141801] [012/133] (937s left) gem_exec_flush (basic-wb-rw-default)
[80.208361] Starting subtest: basic-wb-rw-default
[85.652371] Subtest basic-wb-rw-default: SUCCESS (5.446s)
[85.860869] [013/133] (931s left) kms_ccs (ccs-on-another-bo-4-tiled-mtl-rc-ccs-cc)
[85.958707] Starting subtest: ccs-on-another-bo-4-tiled-mtl-rc-ccs-cc
[85.961042] Starting dynamic subtest: pipe-A-eDP-1
[85.981671] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[85.992845] Starting dynamic subtest: pipe-B-eDP-1
[86.012662] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[86.019530] Starting dynamic subtest: pipe-C-eDP-1
[86.038250] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[86.044973] Starting dynamic subtest: pipe-D-eDP-1
[86.064293] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[86.066144] Subtest ccs-on-another-bo-4-tiled-mtl-rc-ccs-cc: SUCCESS (0.006s)
[88.210576] [014/133] (929s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-shrfb-draw-blt)
[88.313228] Starting subtest: fbc-1p-offscreen-pri-shrfb-draw-blt
[92.441610] Subtest fbc-1p-offscreen-pri-shrfb-draw-blt: SUCCESS (4.132s)
[93.612705] [015/133] (923s left) kms_cursor_edge_walk (256x256-top-bottom)
[93.697280] Starting subtest: 256x256-top-bottom
[93.699584] Starting dynamic subtest: pipe-A-eDP-1
[97.157699] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.457s)
[97.166886] Starting dynamic subtest: pipe-D-eDP-1
[100.276217] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.119s)
[100.278646] Subtest 256x256-top-bottom: SUCCESS (6.578s)
[101.122009] [016/133] (916s left) kms_force_connector_basic (force-load-detect)
[101.209028] Starting subtest: force-load-detect
[101.213674] Subtest force-load-detect: SKIP (0.000s)
[101.342262] [017/133] (916s left) syncobj_wait (invalid-signal-zero-handles)
[101.396895] Starting subtest: invalid-signal-zero-handles
[101.398895] Subtest invalid-signal-zero-handles: SUCCESS (0.000s)
[101.511571] [018/133] (916s left) kms_psr2_sf (fbc-psr2-cursor-plane-move-continuous-sf)
[106.479716] Starting subtest: fbc-psr2-cursor-plane-move-continuous-sf
[106.482029] Starting dynamic subtest: pipe-A-eDP-1
[107.274576] Dynamic subtest pipe-A-eDP-1: SKIP (0.793s)
[107.283746] Starting dynamic subtest: pipe-B-eDP-1
[108.417352] Dynamic subtest pipe-B-eDP-1: SKIP (1.140s)
[108.421560] Subtest fbc-psr2-cursor-plane-move-continuous-sf: SKIP (1.937s)
[109.622147] [019/133] (907s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-render)
[109.731257] Starting subtest: fbcpsr-rgb565-draw-render
[116.729063] Subtest fbcpsr-rgb565-draw-render: SUCCESS (7.002s)
[116.893682] [020/133] (900s left) kms_rotation_crc (primary-4-tiled-reflect-x-0)
[117.001615] Starting subtest: primary-4-tiled-reflect-x-0
[124.199160] Subtest primary-4-tiled-reflect-x-0: SUCCESS (7.197s)
[125.397673] [021/133] (892s left) kms_setmode (clone-exclusive-crtc)
[125.457888] Starting subtest: clone-exclusive-crtc
[125.464382] Subtest clone-exclusive-crtc: SKIP (0.000s)
[125.577895] [022/133] (892s left) kms_addfb_basic (too-high)
[125.691936] Starting subtest: too-high
[125.693860] Subtest too-high: SUCCESS (0.000s)
[125.808830] [023/133] (891s left) perf_pmu (busy-accuracy-2)
[125.855047] Starting subtest: busy-accuracy-2
[125.857220] Starting dynamic subtest: rcs0
[128.897619] Dynamic subtest rcs0: SUCCESS (3.041s)
[128.907864] Starting dynamic subtest: bcs0
[131.955678] Dynamic subtest bcs0: SUCCESS (3.057s)
[131.966399] Starting dynamic subtest: vcs0
[135.002345] Dynamic subtest vcs0: SUCCESS (3.044s)
[135.012637] Starting dynamic subtest: vcs1
[138.052390] Dynamic subtest vcs1: SUCCESS (3.048s)
[138.063132] Starting dynamic subtest: vecs0
[141.100571] Dynamic subtest vecs0: SUCCESS (3.046s)
[141.110865] Starting dynamic subtest: ccs0
[144.161927] Dynamic subtest ccs0: SUCCESS (3.059s)
[144.164429] Subtest busy-accuracy-2: SUCCESS (18.307s)
[144.301859] [024/133] (873s left) kms_psr (pr-primary-mmap-gtt)
[144.391054] Starting subtest: pr-primary-mmap-gtt
[144.395473] Subtest pr-primary-mmap-gtt: SKIP (0.000s)
[144.485926] [025/133] (873s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-indfb-pgflip-blt)
[144.583369] Starting subtest: fbc-2p-scndscrn-indfb-pgflip-blt
[144.587683] Subtest fbc-2p-scndscrn-indfb-pgflip-blt: SKIP (0.000s)
[144.714859] [026/133] (873s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-mmap-cpu)
[144.824809] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-mmap-cpu
[144.829187] Subtest psr-2p-scndscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[144.933967] [027/133] (872s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-16bpp-4tile-upscaling)
[145.037946] Starting subtest: flip-64bpp-4tile-to-16bpp-4tile-upscaling
[145.040119] Starting dynamic subtest: pipe-A-default-mode
[147.794088] Dynamic subtest pipe-A-default-mode: SUCCESS (2.755s)
[147.796498] Subtest flip-64bpp-4tile-to-16bpp-4tile-upscaling: SUCCESS (2.757s)
[148.685355] [028/133] (869s left) i915_drm_fdinfo (idle)
[148.732117] Starting subtest: idle
[148.734037] Starting dynamic subtest: rcs0
[149.336482] Dynamic subtest rcs0: SUCCESS (0.605s)
[149.349118] Starting dynamic subtest: bcs0
[149.843576] Dynamic subtest bcs0: SUCCESS (0.504s)
[149.854975] Starting dynamic subtest: vcs0
[150.348947] Dynamic subtest vcs0: SUCCESS (0.503s)
[150.358875] Starting dynamic subtest: vcs1
[150.854025] Dynamic subtest vcs1: SUCCESS (0.503s)
[150.863647] Starting dynamic subtest: vecs0
[151.359291] Dynamic subtest vecs0: SUCCESS (0.503s)
[151.370622] Starting dynamic subtest: ccs0
[151.864946] Dynamic subtest ccs0: SUCCESS (0.503s)
[151.867734] Subtest idle: SUCCESS (3.133s)
[151.959737] [029/133] (865s left) core_setmaster (master-drop-set-shared-fd)
[152.058380] Starting subtest: master-drop-set-shared-fd
[152.080250] Subtest master-drop-set-shared-fd: SUCCESS (0.022s)
[152.115314] [030/133] (865s left) kms_chamelium_color (ctm-negative)
[152.213261] Subtest ctm-negative: SKIP (0.000s)
[152.271525] [031/133] (865s left) syncobj_timeline (multi-wait-for-submit-available-submitted)
[152.332068] Starting subtest: multi-wait-for-submit-available-submitted
[152.333969] Subtest multi-wait-for-submit-available-submitted: SUCCESS (0.000s)
[152.462122] [032/133] (865s left) syncobj_timeline (invalid-signal-illegal-point)
[152.528236] Starting subtest: invalid-signal-illegal-point
[152.530431] Subtest invalid-signal-illegal-point: SUCCESS (0.000s)
[152.641915] [033/133] (865s left) gem_mmap (bad-offset)
[152.708080] Subtest bad-offset: SKIP (0.000s)
[152.767310] [034/133] (865s left) i915_hangman (gt-error-state-capture)
[152.832715] Starting subtest: gt-error-state-capture
[152.835023] Starting dynamic subtest: rcs0
[163.892380] Dynamic subtest rcs0: SUCCESS (11.058s)
[163.903238] Starting dynamic subtest: bcs0
[175.860477] Dynamic subtest bcs0: SUCCESS (11.964s)
[175.871840] Starting dynamic subtest: vcs0
[185.843580] Dynamic subtest vcs0: SUCCESS (9.981s)
[185.855688] Starting dynamic subtest: vcs1
[196.849849] Dynamic subtest vcs1: SUCCESS (11.004s)
[196.860854] Starting dynamic subtest: vecs0
[208.818041] Dynamic subtest vecs0: SUCCESS (11.966s)
[208.829802] Starting dynamic subtest: ccs0
[219.917515] Dynamic subtest ccs0: SUCCESS (11.069s)
[219.922300] Subtest gt-error-state-capture: SUCCESS (67.055s)
[219.987822] [035/133] (798s left) kms_ccs (crc-primary-suspend-4-tiled-dg2-rc-ccs)
[220.089828] Starting subtest: crc-primary-suspend-4-tiled-dg2-rc-ccs
[220.092145] Starting dynamic subtest: pipe-A-eDP-1
[220.101060] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[220.113137] Starting dynamic subtest: pipe-B-eDP-1
[220.122259] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[220.130980] Starting dynamic subtest: pipe-C-eDP-1
[220.139316] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[220.147300] Starting dynamic subtest: pipe-D-eDP-1
[220.155763] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[220.160081] Subtest crc-primary-suspend-4-tiled-dg2-rc-ccs: SKIP (0.004s)
[222.344638] [036/133] (795s left) gem_exec_whisper (basic-fds)
[222.411864] Starting subtest: basic-fds
[229.876538] Subtest basic-fds: SUCCESS (7.463s)
[230.082304] [037/133] (788s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-move)
[230.202672] Starting subtest: psr-1p-primscrn-cur-indfb-move
[237.549676] Subtest psr-1p-primscrn-cur-indfb-move: SUCCESS (7.349s)
[237.743058] [038/133] (780s left) gem_exec_schedule (preempt-user)
[237.823310] Starting subtest: preempt-user
[237.825440] Starting dynamic subtest: rcs0
[237.836810] Dynamic subtest rcs0: SUCCESS (0.022s)
[237.848580] Starting dynamic subtest: bcs0
[237.854825] Dynamic subtest bcs0: SUCCESS (0.018s)
[237.863712] Starting dynamic subtest: vcs0
[237.875219] Dynamic subtest vcs0: SUCCESS (0.019s)
[237.885563] Starting dynamic subtest: vcs1
[237.896679] Dynamic subtest vcs1: SUCCESS (0.021s)
[237.905618] Starting dynamic subtest: vecs0
[237.915304] Dynamic subtest vecs0: SUCCESS (0.018s)
[237.923308] Starting dynamic subtest: ccs0
[237.938196] Dynamic subtest ccs0: SUCCESS (0.022s)
[237.940468] Subtest preempt-user: SUCCESS (0.124s)
[239.996915] [039/133] (778s left) kms_psr (psr2-primary-mmap-cpu)
[240.087592] Starting subtest: psr2-primary-mmap-cpu
[240.089934] Starting dynamic subtest: eDP-1
[241.821940] Dynamic subtest eDP-1: SUCCESS (1.732s)
[241.824215] Subtest psr2-primary-mmap-cpu: SUCCESS (1.733s)
[242.711255] [040/133] (775s left) gem_ctx_param (invalid-size-set)
[242.784905] Starting subtest: invalid-size-set
[242.787419] Subtest invalid-size-set: SUCCESS (0.001s)
[242.914487] [041/133] (775s left) kms_ccs (bad-aux-stride-y-tiled-ccs)
[243.005761] Starting subtest: bad-aux-stride-y-tiled-ccs
[243.008050] Starting dynamic subtest: pipe-A-eDP-1
[243.030663] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[243.040151] Starting dynamic subtest: pipe-B-eDP-1
[243.062201] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[243.070392] Starting dynamic subtest: pipe-C-eDP-1
[243.092314] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[243.101603] Starting dynamic subtest: pipe-D-eDP-1
[243.122841] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[243.126898] Subtest bad-aux-stride-y-tiled-ccs: SKIP (0.004s)
[245.178717] [042/133] (773s left) kms_flip (blocking-absolute-wf_vblank-interruptible)
[245.272757] Starting subtest: blocking-absolute-wf_vblank-interruptible
[245.275119] Starting dynamic subtest: A-eDP1
[254.023934] Dynamic subtest A-eDP1: SUCCESS (8.750s)
[254.032731] Starting dynamic subtest: B-eDP1
[262.745699] Dynamic subtest B-eDP1: SUCCESS (8.721s)
[262.757332] Starting dynamic subtest: C-eDP1
[271.465894] Dynamic subtest C-eDP1: SUCCESS (8.718s)
[271.475065] Starting dynamic subtest: D-eDP1
[280.201909] Dynamic subtest D-eDP1: SUCCESS (8.734s)
[280.204354] Subtest blocking-absolute-wf_vblank-interruptible: SUCCESS (34.932s)
[281.440031] [043/133] (737s left) kms_psr2_su (page_flip-nv12)
[281.503210] Subtest page_flip-NV12: SKIP (0.000s)
[281.568092] [044/133] (736s left) gem_exec_balancer (sliced)
[281.633503] Starting subtest: sliced
[281.637963] Subtest sliced: SKIP (0.000s)
[281.963323] [045/133] (736s left) kms_plane_lowres (tiling-x)
[282.061738] Starting subtest: tiling-x
[282.064027] Starting dynamic subtest: pipe-A-eDP-1
[282.068548] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[282.355425] Starting dynamic subtest: pipe-B-eDP-1
[282.359985] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[282.368401] Starting dynamic subtest: pipe-C-eDP-1
[282.372957] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[282.381303] Starting dynamic subtest: pipe-D-eDP-1
[282.385615] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[282.389946] Subtest tiling-x: SKIP (0.293s)
[283.161084] [046/133] (735s left) kms_vblank (query-busy-hang)
[283.274371] Starting subtest: query-busy-hang
[283.276643] Starting dynamic subtest: pipe-A-eDP-1
[309.662904] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.383s)
[309.679612] Starting dynamic subtest: pipe-D-eDP-1
[324.763991] Dynamic subtest pipe-D-eDP-1: SUCCESS (15.097s)
[324.766056] Subtest query-busy-hang: SUCCESS (41.485s)
[325.630767] [047/133] (693s left) gem_exec_balancer (hang)
[325.912107] Starting subtest: hang
[327.924901] Subtest hang: SUCCESS (2.015s)
[328.082283] [048/133] (690s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-mmap-gtt)
[328.193213] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-mmap-gtt
[328.197137] Subtest psr-2p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[328.330776] [049/133] (690s left) kms_flip (bo-too-big)
[328.430373] Starting subtest: bo-too-big
[328.432685] Starting dynamic subtest: A-eDP1
[329.752707] Dynamic subtest A-eDP1: SUCCESS (1.321s)
[329.772735] Starting dynamic subtest: B-eDP1
[331.087673] Dynamic subtest B-eDP1: SUCCESS (1.332s)
[331.101389] Starting dynamic subtest: C-eDP1
[332.424849] Dynamic subtest C-eDP1: SUCCESS (1.334s)
[332.434327] Starting dynamic subtest: D-eDP1
[333.764573] Dynamic subtest D-eDP1: SUCCESS (1.337s)
[333.770562] Subtest bo-too-big: SUCCESS (5.340s)
[334.988850] [050/133] (683s left) gem_render_copy (mixed-tiled-to-yf-tiled-ccs)
[335.063743] Starting subtest: mixed-tiled-to-yf-tiled-ccs
[335.068293] Subtest mixed-tiled-to-yf-tiled-ccs: SKIP (0.000s)
[335.270458] [051/133] (683s left) kms_cursor_legacy (single-bo)
[335.398641] Starting subtest: single-bo
[335.400665] Starting dynamic subtest: pipe-A
[340.781748] Dynamic subtest pipe-A: SUCCESS (5.380s)
[340.793351] Starting dynamic subtest: pipe-B
[346.164870] Dynamic subtest pipe-B: SUCCESS (5.380s)
[346.175923] Starting dynamic subtest: pipe-C
[351.547837] Dynamic subtest pipe-C: SUCCESS (5.380s)
[351.559193] Starting dynamic subtest: pipe-D
[356.930519] Dynamic subtest pipe-D: SUCCESS (5.379s)
[356.941789] Starting dynamic subtest: all-pipes
[362.320265] Dynamic subtest all-pipes: SUCCESS (5.387s)
[362.322818] Subtest single-bo: SUCCESS (26.920s)
[362.489388] [052/133] (656s left) kms_pm_rpm (basic-pci-d3-state)
[364.127408] Starting subtest: basic-pci-d3-state
[365.602871] Subtest basic-pci-d3-state: SUCCESS (1.479s)
[365.698227] [053/133] (653s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-pwrite)
[365.797619] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-pwrite
[370.140211] Subtest fbc-1p-primscrn-spr-indfb-draw-pwrite: SUCCESS (4.345s)
[371.367334] [054/133] (647s left) kms_pm_rpm (legacy-planes)
[373.000810] Starting subtest: legacy-planes
[373.003209] Starting dynamic subtest: plane-63
[381.723414] Dynamic subtest plane-63: SUCCESS (8.725s)
[381.734767] Starting dynamic subtest: plane-93
[390.073812] Dynamic subtest plane-93: SUCCESS (8.347s)
[390.085396] Starting dynamic subtest: plane-123
[398.393504] Dynamic subtest plane-123: SUCCESS (8.317s)
[398.403510] Starting dynamic subtest: plane-133
[406.709828] Dynamic subtest plane-133: SUCCESS (8.313s)
[406.712721] Subtest legacy-planes: SUCCESS (33.712s)
[407.118447] [055/133] (611s left) prime_self_import (basic-with_one_bo)
[407.157776] Starting subtest: basic-with_one_bo
[407.184942] Subtest basic-with_one_bo: SUCCESS (0.027s)
[407.322867] [056/133] (611s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-mmap-wc)
[407.419399] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-mmap-wc
[407.423744] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[407.547364] [057/133] (611s left) kms_flip (modeset-vs-vblank-race)
[407.642499] Starting subtest: modeset-vs-vblank-race
[407.644629] Starting dynamic subtest: A-eDP1
[412.326987] Dynamic subtest A-eDP1: SUCCESS (4.685s)
[412.337077] Starting dynamic subtest: B-eDP1
[417.073405] Dynamic subtest B-eDP1: SUCCESS (4.744s)
[417.085216] Starting dynamic subtest: C-eDP1
[421.745122] Dynamic subtest C-eDP1: SUCCESS (4.670s)
[421.757486] Starting dynamic subtest: D-eDP1
[426.353723] Dynamic subtest D-eDP1: SUCCESS (4.605s)
[426.360510] Subtest modeset-vs-vblank-race: SUCCESS (18.721s)
[427.644349] [058/133] (591s left) gem_lmem_swapping (heavy-verify-random-ccs)
[427.690658] Subtest heavy-verify-random-ccs: SKIP (0.000s)
[427.726721] [059/133] (591s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-gtt)
[427.833270] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-gtt
[427.837479] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[427.949038] [060/133] (591s left) kms_chamelium_color (gamma)
[428.049031] Subtest gamma: SKIP (0.000s)
[428.090053] [061/133] (591s left) kms_cursor_legacy (cursorb-vs-flipa-varying-size)
[428.218372] Starting subtest: cursorB-vs-flipA-varying-size
[428.222632] Subtest cursorB-vs-flipA-varying-size: SKIP (0.001s)
[428.385498] [062/133] (590s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-render)
[428.488440] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-render
[432.952546] Subtest fbc-1p-primscrn-pri-shrfb-draw-render: SUCCESS (4.469s)
[434.142960] [063/133] (585s left) dumb_buffer (map-valid)
[434.207141] Starting subtest: map-valid
[434.209346] Subtest map-valid: SUCCESS (0.000s)
[434.335350] [064/133] (584s left) kms_flip_scaled_crc (flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling)
[434.427765] Starting subtest: flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling
[434.430030] Starting dynamic subtest: pipe-A-default-mode
[434.737918] Dynamic subtest pipe-A-default-mode: SKIP (0.306s)
[434.742315] Subtest flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling: SKIP (0.308s)
[435.587649] [065/133] (583s left) perf (i915-ref-count)
[435.691832] Starting subtest: i915-ref-count
[435.765137] Subtest i915-ref-count: SUCCESS (0.071s)
[435.834050] [066/133] (583s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-mmap-cpu)
[435.941243] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-mmap-cpu
[435.945623] Subtest fbc-2p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[436.084269] [067/133] (583s left) gem_softpin (noreloc-interruptible)
[436.150887] Starting subtest: noreloc-interruptible
[441.564063] Subtest noreloc-interruptible: SUCCESS (5.412s)
[441.720678] [068/133] (577s left) kms_psr (fbc-psr2-primary-render)
[441.821105] Starting subtest: fbc-psr2-primary-render
[441.823465] Starting dynamic subtest: eDP-1
[441.827921] Dynamic subtest eDP-1: SKIP (0.000s)
[441.832311] Subtest fbc-psr2-primary-render: SKIP (0.001s)
[441.916695] [069/133] (577s left) kms_lease (atomic-implicit-crtc)
[442.009038] Starting subtest: atomic-implicit-crtc
[442.011266] Starting dynamic subtest: pipe-A-eDP-1
[442.022838] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[442.032619] Starting dynamic subtest: pipe-B-eDP-1
[442.043904] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.009s)
[442.052574] Starting dynamic subtest: pipe-C-eDP-1
[442.063410] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.009s)
[442.072021] Starting dynamic subtest: pipe-D-eDP-1
[442.082665] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.009s)
[442.084859] Subtest atomic-implicit-crtc: SUCCESS (0.034s)
[442.179015] [070/133] (577s left) kms_async_flips (async-flip-with-page-flip-events-linear-atomic)
[442.275431] Starting subtest: async-flip-with-page-flip-events-linear-atomic
[442.646495] Starting dynamic subtest: pipe-A-eDP-1
[445.408362] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.761s)
[445.781846] Starting dynamic subtest: pipe-B-eDP-1
[448.539842] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.773s)
[448.901779] Starting dynamic subtest: pipe-C-eDP-1
[451.663085] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.768s)
[452.026819] Starting dynamic subtest: pipe-D-eDP-1
[454.798796] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.778s)
[454.801638] Subtest async-flip-with-page-flip-events-linear-atomic: SUCCESS (12.524s)
[456.002569] [071/133] (563s left) gem_exec_reloc (basic-wc-read-active)
[456.079571] Subtest basic-wc-read-active: SKIP (0.000s)
[456.173356] [072/133] (563s left) gem_readwrite (new-obj)
[456.233291] Subtest new-obj: SKIP (0.000s)
[456.298836] [073/133] (563s left) gem_mmap_gtt (basic-short)
[456.354862] Subtest basic-short: SKIP (0.000s)
[456.426337] [074/133] (563s left) kms_plane_multiple (tiling-yf)
[456.522108] Starting subtest: tiling-yf
[456.526794] Subtest tiling-yf: SKIP (0.000s)
[456.617239] [075/133] (563s left) kms_content_protection (dp-mst-type-0-hdcp14)
[456.762046] Starting subtest: dp-mst-type-0-hdcp14
[456.766515] Subtest dp-mst-type-0-hdcp14: SKIP (0.000s)
[456.928104] [076/133] (562s left) gem_ctx_shared (q-in-order)
[456.986528] Starting subtest: Q-in-order
[456.988465] Starting dynamic subtest: rcs0
[457.164716] Dynamic subtest rcs0: SUCCESS (0.177s)
[457.179571] Starting dynamic subtest: vcs0
[457.241649] Dynamic subtest vcs0: SUCCESS (0.076s)
[457.258930] Starting dynamic subtest: vcs1
[457.315269] Dynamic subtest vcs1: SUCCESS (0.073s)
[457.331226] Starting dynamic subtest: vecs0
[457.390559] Dynamic subtest vecs0: SUCCESS (0.074s)
[457.407015] Starting dynamic subtest: ccs0
[457.479775] Dynamic subtest ccs0: SUCCESS (0.088s)
[457.481888] Subtest Q-in-order: SUCCESS (0.493s)
[459.034815] [FACT gem_ctx_shared (q-in-order)] new: kernel.kmod_is_loaded.vgem: true
[459.038021] [077/133] (560s left) syncobj_timeline (etime-single-wait-all-for-submit-unsubmitted)
[459.100489] Starting subtest: etime-single-wait-all-for-submit-unsubmitted
[459.208860] Subtest etime-single-wait-all-for-submit-unsubmitted: SUCCESS (0.108s)
[459.309947] [078/133] (560s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-mmap-wc)
[459.412158] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-mmap-wc
[465.996780] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-mmap-wc: SUCCESS (6.586s)
[466.169292] [079/133] (553s left) kms_big_fb (linear-8bpp-rotate-270)
[466.281194] Starting subtest: linear-8bpp-rotate-270
[466.301310] Subtest linear-8bpp-rotate-270: SKIP (0.020s)
[466.452445] [080/133] (553s left) api_intel_allocator (standalone)
[466.505479] Starting subtest: standalone
[466.519812] Subtest standalone: SUCCESS (0.017s)
[466.688285] [081/133] (553s left) core_auth (getclient-master-drop)
[466.728817] Starting subtest: getclient-master-drop
[466.753391] Subtest getclient-master-drop: SUCCESS (0.026s)
[466.906128] [082/133] (553s left) kms_psr (fbc-psr2-basic)
[467.000823] Starting subtest: fbc-psr2-basic
[467.002969] Starting dynamic subtest: eDP-1
[467.006886] Dynamic subtest eDP-1: SKIP (0.000s)
[467.010518] Subtest fbc-psr2-basic: SKIP (0.001s)
[467.095088] [083/133] (553s left) kms_cursor_crc (cursor-rapid-movement-32x32)
[467.248806] Starting subtest: cursor-rapid-movement-32x32
[467.293508] Subtest cursor-rapid-movement-32x32: SKIP (0.041s)
[467.617983] [084/133] (552s left) gem_exec_schedule (noreorder-priority)
[467.817475] Starting subtest: noreorder-priority
[467.819749] Starting dynamic subtest: rcs0
[468.972058] Dynamic subtest rcs0: SUCCESS (1.153s)
[468.984516] Starting dynamic subtest: vcs0
[470.960299] Dynamic subtest vcs0: SUCCESS (1.985s)
[470.976660] Starting dynamic subtest: vcs1
[472.929817] Dynamic subtest vcs1: SUCCESS (1.967s)
[472.942890] Starting dynamic subtest: vecs0
[474.908657] Dynamic subtest vecs0: SUCCESS (1.953s)
[474.917327] Starting dynamic subtest: ccs0
[476.035918] Dynamic subtest ccs0: SUCCESS (1.150s)
[476.038542] Subtest noreorder-priority: SUCCESS (8.219s)
[476.251641] [085/133] (543s left) kms_ccs (random-ccs-data-4-tiled-dg2-rc-ccs)
[476.357982] Starting subtest: random-ccs-data-4-tiled-dg2-rc-ccs
[476.360326] Starting dynamic subtest: pipe-A-eDP-1
[476.384641] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[476.395038] Starting dynamic subtest: pipe-B-eDP-1
[476.418050] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[476.426590] Starting dynamic subtest: pipe-C-eDP-1
[476.449772] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[476.458993] Starting dynamic subtest: pipe-D-eDP-1
[476.484319] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[476.488371] Subtest random-ccs-data-4-tiled-dg2-rc-ccs: SKIP (0.004s)
[478.530249] [086/133] (541s left) core_auth (many-magics)
[478.587953] Starting subtest: many-magics
[479.467183] Subtest many-magics: SUCCESS (0.881s)
[479.689824] [087/133] (540s left) i915_suspend (fence-restore-tiled2untiled)
[479.752074] Starting subtest: fence-restore-tiled2untiled
[479.756831] Subtest fence-restore-tiled2untiled: SKIP (0.000s)
[479.885590] [088/133] (540s left) kms_plane_scaling (planes-upscale-factor-0-25-downscale-factor-0-5)
[479.989157] Starting subtest: planes-upscale-factor-0-25-downscale-factor-0-5
[479.991445] Starting dynamic subtest: pipe-A
[480.032063] Dynamic subtest pipe-A: SKIP (0.036s)
[480.043177] Starting dynamic subtest: pipe-B
[480.076066] Dynamic subtest pipe-B: SKIP (0.041s)
[480.084832] Starting dynamic subtest: pipe-C
[480.104445] Dynamic subtest pipe-C: SKIP (0.029s)
[480.113479] Starting dynamic subtest: pipe-D
[480.135532] Dynamic subtest pipe-D: SKIP (0.030s)
[480.139367] Subtest planes-upscale-factor-0-25-downscale-factor-0-5: SKIP (0.141s)
[480.247404] [089/133] (540s left) kms_big_fb (y-tiled-64bpp-rotate-0)
[480.348207] Starting subtest: y-tiled-64bpp-rotate-0
[480.352745] Subtest y-tiled-64bpp-rotate-0: SKIP (0.000s)
[480.467280] [090/133] (539s left) gem_ctx_persistence (saturated-hostile)
[480.529855] Starting subtest: saturated-hostile
[480.532184] Starting dynamic subtest: rcs0
[481.383277] Dynamic subtest rcs0: SUCCESS (0.852s)
[481.396042] Starting dynamic subtest: bcs0
[482.185232] Dynamic subtest bcs0: SUCCESS (0.801s)
[482.197375] Starting dynamic subtest: vcs0
[482.987275] Dynamic subtest vcs0: SUCCESS (0.800s)
[482.999234] Starting dynamic subtest: vcs1
[483.803457] Dynamic subtest vcs1: SUCCESS (0.814s)
[483.815159] Starting dynamic subtest: vecs0
[484.609790] Dynamic subtest vecs0: SUCCESS (0.804s)
[484.621494] Starting dynamic subtest: ccs0
[485.473785] Dynamic subtest ccs0: SUCCESS (0.862s)
[485.476473] Subtest saturated-hostile: SUCCESS (4.944s)
[485.580086] [091/133] (534s left) kms_prop_blob (invalid-get-prop)
[485.646703] Starting subtest: invalid-get-prop
[485.648736] Subtest invalid-get-prop: SUCCESS (0.000s)
[485.785392] [092/133] (534s left) gem_mmap_gtt (basic-write)
[485.842270] Subtest basic-write: SKIP (0.000s)
[485.901902] [093/133] (534s left) kms_cursor_legacy (cursora-vs-flipa-varying-size)
[486.021291] Starting subtest: cursorA-vs-flipA-varying-size
[497.166346] Subtest cursorA-vs-flipA-varying-size: SUCCESS (11.145s)
[498.062745] [094/133] (522s left) gem_linear_blits (interruptible)
[498.450750] Starting subtest: interruptible
[502.448778] Subtest interruptible: SUCCESS (3.997s)
[502.651801] [095/133] (517s left) gem_exec_params (sol-reset-invalid)
[502.751946] Starting subtest: sol-reset-invalid
[502.757690] Subtest sol-reset-invalid: SUCCESS (0.004s)
[504.008850] [096/133] (516s left) kms_color_pipeline (plane-lut1d)
[504.109981] Starting subtest: plane-lut1d
[504.122738] Starting dynamic subtest: pipe-A-eDP-1
[504.819082] Dynamic subtest pipe-A-eDP-1: FAIL (0.310s)
[505.520748] Starting dynamic subtest: pipe-B-eDP-1
[506.361115] Dynamic subtest pipe-B-eDP-1: FAIL (0.324s)
[506.950287] Starting dynamic subtest: pipe-C-eDP-1
[507.808492] Dynamic subtest pipe-C-eDP-1: FAIL (0.257s)
[508.276072] Starting dynamic subtest: pipe-D-eDP-1
[509.127902] Dynamic subtest pipe-D-eDP-1: FAIL (0.257s)
[509.130563] Subtest plane-lut1d: FAIL (4.711s)
[509.681821] [097/133] (510s left) gem_wait (busy)
[509.771137] Starting subtest: busy
[509.773565] Starting dynamic subtest: all-engines
[511.829295] Dynamic subtest all-engines: SUCCESS (2.056s)
[511.842446] Starting dynamic subtest: rcs0
[512.373625] Dynamic subtest rcs0: SUCCESS (0.543s)
[512.385677] Starting dynamic subtest: bcs0
[512.914491] Dynamic subtest bcs0: SUCCESS (0.540s)
[512.925943] Starting dynamic subtest: vcs0
[514.901121] Dynamic subtest vcs0: SUCCESS (1.984s)
[514.913528] Starting dynamic subtest: vcs1
[516.884821] Dynamic subtest vcs1: SUCCESS (1.980s)
[516.897818] Starting dynamic subtest: vecs0
[518.932733] Dynamic subtest vecs0: SUCCESS (2.045s)
[518.945325] Starting dynamic subtest: ccs0
[519.474650] Dynamic subtest ccs0: SUCCESS (0.541s)
[519.477151] Subtest busy: SUCCESS (9.704s)
[519.699583] [098/133] (501s left) sriov_basic (enable-vfs-autoprobe-on)
[519.762591] Starting subtest: enable-vfs-autoprobe-on
[519.765249] Starting dynamic subtest: numvfs-1
[519.848633] Dynamic subtest numvfs-1: FAIL (0.005s)
[519.859518] Starting dynamic subtest: numvfs-2
[519.929882] Dynamic subtest numvfs-2: FAIL (0.003s)
[519.940304] Starting dynamic subtest: numvfs-3
[520.012579] Dynamic subtest numvfs-3: FAIL (0.003s)
[520.023277] Starting dynamic subtest: numvfs-4
[520.095043] Dynamic subtest numvfs-4: FAIL (0.003s)
[520.105581] Starting dynamic subtest: numvfs-5
[520.177900] Dynamic subtest numvfs-5: FAIL (0.003s)
[520.188264] Starting dynamic subtest: numvfs-6
[520.260043] Dynamic subtest numvfs-6: FAIL (0.004s)
[520.270512] Starting dynamic subtest: numvfs-7
[520.343255] Dynamic subtest numvfs-7: FAIL (0.003s)
[520.353644] Starting dynamic subtest: numvfs-random
[520.423907] Dynamic subtest numvfs-random: FAIL (0.004s)
[520.434647] Starting dynamic subtest: numvfs-all
[520.506431] Dynamic subtest numvfs-all: FAIL (0.514s)
[520.508711] Subtest enable-vfs-autoprobe-on: FAIL (0.552s)
[520.547316] [099/133] (500s left) kms_chamelium_frames (vga-frame-dump)
[520.934165] Subtest vga-frame-dump: SKIP (0.000s)
[521.756114] [100/133] (499s left) gem_eio (throttle)
[521.944713] Starting subtest: throttle
[522.239546] Subtest throttle: SUCCESS (0.294s)
[522.413220] [101/133] (498s left) kms_frontbuffer_tracking (psr-abgr161616f-draw-mmap-wc)
[522.522770] Starting subtest: psr-abgr161616f-draw-mmap-wc
[522.526722] Subtest psr-abgr161616f-draw-mmap-wc: SKIP (0.000s)
[522.664568] [102/133] (498s left) gem_softpin (allocator-nopin)
[522.724496] Starting subtest: allocator-nopin
[522.839909] Subtest allocator-nopin: SUCCESS (0.113s)
[523.008728] [103/133] (497s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip)
[523.117161] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip
[523.807857] Subtest x-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip: SUCCESS (0.692s)
[524.028317] [104/133] (496s left) kms_flip (busy-flip)
[524.125461] Starting subtest: busy-flip
[524.127384] Starting dynamic subtest: A-eDP1
[525.783666] Dynamic subtest A-eDP1: SUCCESS (1.659s)
[525.794323] Starting dynamic subtest: B-eDP1
[527.421633] Dynamic subtest B-eDP1: SUCCESS (1.637s)
[527.433412] Starting dynamic subtest: C-eDP1
[529.046250] Dynamic subtest C-eDP1: SUCCESS (1.623s)
[529.059020] Starting dynamic subtest: D-eDP1
[530.675103] Dynamic subtest D-eDP1: SUCCESS (1.628s)
[530.679877] Subtest busy-flip: SUCCESS (6.556s)
[531.862986] [105/133] (489s left) kms_big_fb (x-tiled-16bpp-rotate-270)
[531.961179] Starting subtest: x-tiled-16bpp-rotate-270
[531.980761] Subtest x-tiled-16bpp-rotate-270: SKIP (0.019s)
[532.141036] [106/133] (488s left) kms_frontbuffer_tracking (fbcpsr-abgr161616f-draw-render)
[532.237353] Starting subtest: fbcpsr-abgr161616f-draw-render
[532.241832] Subtest fbcpsr-abgr161616f-draw-render: SKIP (0.000s)
[532.372962] [107/133] (488s left) kms_getfb (getfb2-accept-nv12)
[532.479910] Starting subtest: getfb2-accept-nv12
[532.482256] Subtest getfb2-accept-nv12: SUCCESS (0.001s)
[532.619398] [108/133] (488s left) gem_ctx_exec (basic-nohangcheck)
[532.682675] Starting subtest: basic-nohangcheck
[532.942054] Subtest basic-nohangcheck: SUCCESS (0.262s)
[533.096983] [109/133] (488s left) kms_cursor_legacy (short-flip-before-cursor-atomic-transitions)
[533.227998] Starting subtest: short-flip-before-cursor-atomic-transitions
[534.162414] Subtest short-flip-before-cursor-atomic-transitions: SUCCESS (0.935s)
[534.985643] [110/133] (486s left) kms_cursor_crc (cursor-offscreen-256x256)
[535.237833] Starting subtest: cursor-offscreen-256x256
[535.242882] Starting dynamic subtest: pipe-A-eDP-1
[537.205287] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.961s)
[537.236507] Starting dynamic subtest: pipe-D-eDP-1
[539.804749] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.575s)
[539.806645] Subtest cursor-offscreen-256x256: SUCCESS (4.565s)
[540.675732] [111/133] (480s left) kms_big_fb (4-tiled-8bpp-rotate-0)
[540.777063] Starting subtest: 4-tiled-8bpp-rotate-0
[542.000939] Subtest 4-tiled-8bpp-rotate-0: SUCCESS (1.223s)
[542.175259] [112/133] (479s left) gem_tiled_partial_pwrite_pread (writes-after-reads)
[542.244286] Subtest writes-after-reads: SKIP (0.000s)
[542.330191] [113/133] (479s left) kms_frontbuffer_tracking (psr-slowdraw)
[542.432234] Starting subtest: psr-slowdraw
[567.696151] Subtest psr-slowdraw: SUCCESS (25.264s)
[567.831291] [114/133] (453s left) i915_pm_rc6_residency (rc6-idle)
[567.901312] Starting subtest: rc6-idle
[567.945982] Starting dynamic subtest: gt0-rcs0
[592.230438] Dynamic subtest gt0-rcs0: SUCCESS (24.283s)
[592.242207] Starting dynamic subtest: gt0-bcs0
[616.568955] Dynamic subtest gt0-bcs0: SUCCESS (24.335s)
[616.578513] Starting dynamic subtest: gt0-ccs0
[640.894602] Dynamic subtest gt0-ccs0: SUCCESS (24.322s)
[640.905982] Starting dynamic subtest: gt1-vcs0
[647.068057] Dynamic subtest gt1-vcs0: SUCCESS (6.170s)
[647.080924] Starting dynamic subtest: gt1-vecs0
[653.239993] Dynamic subtest gt1-vecs0: SUCCESS (6.169s)
[653.242594] Subtest rc6-idle: SUCCESS (85.338s)
[653.343939] [115/133] (368s left) kms_frontbuffer_tracking (fbc-modesetfrombusy)
[653.452570] Starting subtest: fbc-modesetfrombusy
[657.221784] Subtest fbc-modesetfrombusy: SUCCESS (3.772s)
[658.419923] [116/133] (363s left) kms_psr (psr-cursor-render)
[658.523850] Starting subtest: psr-cursor-render
[658.526187] Starting dynamic subtest: eDP-1
[660.269701] Dynamic subtest eDP-1: SUCCESS (1.744s)
[660.271688] Subtest psr-cursor-render: SUCCESS (1.745s)
[661.167029] [117/133] (360s left) gem_exec_parallel (engines)
[661.235697] Starting subtest: engines
[661.238317] Starting dynamic subtest: basic
[662.895559] Dynamic subtest basic: SUCCESS (1.658s)
[662.904979] Starting dynamic subtest: contexts
[667.373147] Dynamic subtest contexts: SUCCESS (4.476s)
[667.382693] Starting dynamic subtest: fds
[671.151989] Dynamic subtest fds: SUCCESS (3.776s)
[671.165304] Starting dynamic subtest: userptr
[672.951085] Dynamic subtest userptr: SUCCESS (1.796s)
[672.953969] Subtest engines: SUCCESS (11.715s)
[673.167763] [118/133] (348s left) prime_busy (after)
[673.222262] Starting subtest: after
[673.227076] Starting dynamic subtest: rcs0
[673.275573] Dynamic subtest rcs0: SUCCESS (0.049s)
[673.287440] Starting dynamic subtest: bcs0
[673.353046] Dynamic subtest bcs0: SUCCESS (0.077s)
[673.364176] Starting dynamic subtest: vcs0
[673.392743] Dynamic subtest vcs0: SUCCESS (0.039s)
[673.402523] Starting dynamic subtest: vcs1
[673.432602] Dynamic subtest vcs1: SUCCESS (0.039s)
[673.441887] Starting dynamic subtest: vecs0
[673.475092] Dynamic subtest vecs0: SUCCESS (0.042s)
[673.484944] Starting dynamic subtest: ccs0
[673.516892] Dynamic subtest ccs0: SUCCESS (0.041s)
[673.625060] Subtest after: SUCCESS (0.401s)
[673.729069] [119/133] (347s left) gem_partial_pwrite_pread (write-display)
[673.790485] Subtest write-display: SKIP (0.000s)
[673.867046] [120/133] (347s left) gem_tiled_blits (basic)
[673.916341] Subtest basic: SKIP (0.000s)
[674.008148] [121/133] (347s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-pwrite)
[674.121787] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-pwrite
[682.456463] Subtest psr-1p-primscrn-pri-shrfb-draw-pwrite: SUCCESS (8.338s)
[682.592556] [122/133] (339s left) sysfs_defaults (readonly)
[682.656914] Starting subtest: readonly
[682.659105] Starting dynamic subtest: vecs0
[682.661365] Dynamic subtest vecs0: SUCCESS (0.000s)
[682.674856] Starting dynamic subtest: ccs0
[682.677083] Dynamic subtest ccs0: SUCCESS (0.000s)
[682.690315] Starting dynamic subtest: vcs0
[682.692470] Dynamic subtest vcs0: SUCCESS (0.000s)
[682.701960] Starting dynamic subtest: bcs0
[682.704301] Dynamic subtest bcs0: SUCCESS (0.000s)
[682.716546] Starting dynamic subtest: rcs0
[682.718410] Dynamic subtest rcs0: SUCCESS (0.000s)
[682.727340] Starting dynamic subtest: vcs1
[682.729535] Dynamic subtest vcs1: SUCCESS (0.000s)
[682.731647] Subtest readonly: SUCCESS (0.005s)
[682.794435] [123/133] (338s left) kms_dsc (dsc-with-formats)
[682.877393] Starting subtest: dsc-with-formats
[682.915980] Subtest dsc-with-formats: SKIP (0.001s)
[682.975026] [124/133] (338s left) prime_mmap (test_reprime)
[683.032445] Starting subtest: test_reprime
[683.034397] Starting dynamic subtest: test_reprime-smem
[683.058153] Dynamic subtest test_reprime-smem: SUCCESS (0.028s)
[683.060535] Subtest test_reprime: SUCCESS (0.029s)
[683.195405] [125/133] (338s left) gem_exec_params (rsvd2-dirt)
[683.254261] Starting subtest: rsvd2-dirt
[683.258584] Subtest rsvd2-dirt: SKIP (0.000s)
[683.379266] [126/133] (338s left) kms_lease (lessee-list)
[683.478834] Starting subtest: lessee-list
[683.480423] Starting dynamic subtest: pipe-A-eDP-1
[683.482315] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[683.492151] Starting dynamic subtest: pipe-B-eDP-1
[683.493753] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[683.502577] Starting dynamic subtest: pipe-C-eDP-1
[683.504159] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[683.513042] Starting dynamic subtest: pipe-D-eDP-1
[683.514657] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[683.516282] Subtest lessee-list: SUCCESS (0.009s)
[683.618643] [127/133] (338s left) kms_vrr (flip-dpms)
[683.713352] Starting subtest: flip-dpms
[683.718388] Subtest flip-dpms: SKIP (0.000s)
[683.809975] [128/133] (338s left) kms_frontbuffer_tracking (fbc-1p-rte)
[683.902805] Starting subtest: fbc-1p-rte
[689.370830] Subtest fbc-1p-rte: SUCCESS (5.469s)
[690.599012] [129/133] (331s left) gen9_exec_parse (batch-zero-length)
[690.664423] Subtest batch-zero-length: SKIP (0.000s)
[690.750796] [130/133] (331s left) prime_mmap (test_aperture_limit)
[690.807996] Starting subtest: test_aperture_limit
[690.810770] Starting dynamic subtest: test_aperture_limit-smem
[690.815866] Dynamic subtest test_aperture_limit-smem: SKIP (0.007s)
[690.820444] Subtest test_aperture_limit: SKIP (0.008s)
[690.950226] [131/133] (331s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-0-async-flip)
[691.048199] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-0-async-flip
[691.052578] Subtest yf-tiled-max-hw-stride-64bpp-rotate-0-async-flip: SKIP (0.000s)
[691.171426] [132/133] (330s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-shrfb-msflip-blt)
[691.279227] Starting subtest: fbcpsr-2p-primscrn-shrfb-msflip-blt
[691.283437] Subtest fbcpsr-2p-primscrn-shrfb-msflip-blt: SKIP (0.000s)
[691.427900] [133/133] (330s left) gem_exec_fence (long-history)
[691.888424] Starting subtest: long-history
[698.641202] Subtest long-history: SUCCESS (6.753s)
[699.153334] Closing watchdogs
results: parsing output: 0/ for test: gem_create
results: parsing output: 1/ for test: gem_userptr_blits
results: parsing output: 2/ for test: gem_pipe_control_store_loop
results: parsing output: 3/ for test: gem_mmap_offset
results: parsing output: 4/ for test: kms_frontbuffer_tracking
results: parsing output: 5/ for test: kms_atomic
results: parsing output: 6/ for test: kms_ccs
results: parsing output: 7/ for test: kms_frontbuffer_tracking
results: parsing output: 8/ for test: gem_render_copy
results: parsing output: 9/ for test: syncobj_timeline
results: parsing output: 10/ for test: gem_pxp
results: parsing output: 11/ for test: gem_exec_flush
results: parsing output: 12/ for test: kms_ccs
results: parsing output: 13/ for test: kms_frontbuffer_tracking
results: parsing output: 14/ for test: kms_cursor_edge_walk
results: parsing output: 15/ for test: kms_force_connector_basic
results: parsing output: 16/ for test: syncobj_wait
results: parsing output: 17/ for test: kms_psr2_sf
results: parsing output: 18/ for test: kms_frontbuffer_tracking
results: parsing output: 19/ for test: kms_rotation_crc
results: parsing output: 20/ for test: kms_setmode
results: parsing output: 21/ for test: kms_addfb_basic
results: parsing output: 22/ for test: perf_pmu
results: parsing output: 23/ for test: kms_psr
results: parsing output: 24/ for test: kms_frontbuffer_tracking
results: parsing output: 25/ for test: kms_frontbuffer_tracking
results: parsing output: 26/ for test: kms_flip_scaled_crc
results: parsing output: 27/ for test: i915_drm_fdinfo
results: parsing output: 28/ for test: core_setmaster
results: parsing output: 29/ for test: kms_chamelium_color
results: parsing output: 30/ for test: syncobj_timeline
results: parsing output: 31/ for test: syncobj_timeline
results: parsing output: 32/ for test: gem_mmap
results: parsing output: 33/ for test: i915_hangman
results: parsing output: 34/ for test: kms_ccs
results: parsing output: 35/ for test: gem_exec_whisper
results: parsing output: 36/ for test: kms_frontbuffer_tracking
results: parsing output: 37/ for test: gem_exec_schedule
results: parsing output: 38/ for test: kms_psr
results: parsing output: 39/ for test: gem_ctx_param
results: parsing output: 40/ for test: kms_ccs
results: parsing output: 41/ for test: kms_flip
results: parsing output: 42/ for test: kms_psr2_su
results: parsing output: 43/ for test: gem_exec_balancer
results: parsing output: 44/ for test: kms_plane_lowres
results: parsing output: 45/ for test: kms_vblank
results: parsing output: 46/ for test: gem_exec_balancer
results: parsing output: 47/ for test: kms_frontbuffer_tracking
results: parsing output: 48/ for test: kms_flip
results: parsing output: 49/ for test: gem_render_copy
results: parsing output: 50/ for test: kms_cursor_legacy
results: parsing output: 51/ for test: kms_pm_rpm
results: parsing output: 52/ for test: kms_frontbuffer_tracking
results: parsing output: 53/ for test: kms_pm_rpm
results: parsing output: 54/ for test: prime_self_import
results: parsing output: 55/ for test: kms_frontbuffer_tracking
results: parsing output: 56/ for test: kms_flip
results: parsing output: 57/ for test: gem_lmem_swapping
results: parsing output: 58/ for test: kms_frontbuffer_tracking
results: parsing output: 59/ for test: kms_chamelium_color
results: parsing output: 60/ for test: kms_cursor_legacy
results: parsing output: 61/ for test: kms_frontbuffer_tracking
results: parsing output: 62/ for test: dumb_buffer
results: parsing output: 63/ for test: kms_flip_scaled_crc
results: parsing output: 64/ for test: perf
results: parsing output: 65/ for test: kms_frontbuffer_tracking
results: parsing output: 66/ for test: gem_softpin
results: parsing output: 67/ for test: kms_psr
results: parsing output: 68/ for test: kms_lease
results: parsing output: 69/ for test: kms_async_flips
results: parsing output: 70/ for test: gem_exec_reloc
results: parsing output: 71/ for test: gem_readwrite
results: parsing output: 72/ for test: gem_mmap_gtt
results: parsing output: 73/ for test: kms_plane_multiple
results: parsing output: 74/ for test: kms_content_protection
results: parsing output: 75/ for test: gem_ctx_shared
results: parsing output: 76/ for test: syncobj_timeline
results: parsing output: 77/ for test: kms_frontbuffer_tracking
results: parsing output: 78/ for test: kms_big_fb
results: parsing output: 79/ for test: api_intel_allocator
results: parsing output: 80/ for test: core_auth
results: parsing output: 81/ for test: kms_psr
results: parsing output: 82/ for test: kms_cursor_crc
results: parsing output: 83/ for test: gem_exec_schedule
results: parsing output: 84/ for test: kms_ccs
results: parsing output: 85/ for test: core_auth
results: parsing output: 86/ for test: i915_suspend
results: parsing output: 87/ for test: kms_plane_scaling
results: parsing output: 88/ for test: kms_big_fb
results: parsing output: 89/ for test: gem_ctx_persistence
results: parsing output: 90/ for test: kms_prop_blob
results: parsing output: 91/ for test: gem_mmap_gtt
results: parsing output: 92/ for test: kms_cursor_legacy
results: parsing output: 93/ for test: gem_linear_blits
results: parsing output: 94/ for test: gem_exec_params
results: parsing output: 95/ for test: kms_color_pipeline
results: parsing output: 96/ for test: gem_wait
results: parsing output: 97/ for test: sriov_basic
results: parsing output: 98/ for test: kms_chamelium_frames
results: parsing output: 99/ for test: gem_eio
results: parsing output: 100/ for test: kms_frontbuffer_tracking
results: parsing output: 101/ for test: gem_softpin
results: parsing output: 102/ for test: kms_big_fb
results: parsing output: 103/ for test: kms_flip
results: parsing output: 104/ for test: kms_big_fb
results: parsing output: 105/ for test: kms_frontbuffer_tracking
results: parsing output: 106/ for test: kms_getfb
results: parsing output: 107/ for test: gem_ctx_exec
results: parsing output: 108/ for test: kms_cursor_legacy
results: parsing output: 109/ for test: kms_cursor_crc
results: parsing output: 110/ for test: kms_big_fb
results: parsing output: 111/ for test: gem_tiled_partial_pwrite_pread
results: parsing output: 112/ for test: kms_frontbuffer_tracking
results: parsing output: 113/ for test: i915_pm_rc6_residency
results: parsing output: 114/ for test: kms_frontbuffer_tracking
results: parsing output: 115/ for test: kms_psr
results: parsing output: 116/ for test: gem_exec_parallel
results: parsing output: 117/ for test: prime_busy
results: parsing output: 118/ for test: gem_partial_pwrite_pread
results: parsing output: 119/ for test: gem_tiled_blits
results: parsing output: 120/ for test: kms_frontbuffer_tracking
results: parsing output: 121/ for test: sysfs_defaults
results: parsing output: 122/ for test: kms_dsc
results: parsing output: 123/ for test: prime_mmap
results: parsing output: 124/ for test: gem_exec_params
results: parsing output: 125/ for test: kms_lease
results: parsing output: 126/ for test: kms_vrr
results: parsing output: 127/ for test: kms_frontbuffer_tracking
results: parsing output: 128/ for test: gen9_exec_parse
results: parsing output: 129/ for test: prime_mmap
results: parsing output: 130/ for test: kms_big_fb
results: parsing output: 131/ for test: kms_frontbuffer_tracking
results: parsing output: 132/ for test: gem_exec_fence
Done.