[59.501298] Initializing watchdogs
[59.501343]   /dev/watchdog0
[59.514776] [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]
[59.518994] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[59.521337] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[59.524571] [001/133] (960s left) kms_frontbuffer_tracking (fbc-1p-primscrn-indfb-pgflip-blt)
[59.648481] Starting subtest: fbc-1p-primscrn-indfb-pgflip-blt
[64.096071] Subtest fbc-1p-primscrn-indfb-pgflip-blt: SUCCESS (4.451s)
[65.288198] [002/133] (954s left) kms_cursor_crc (cursor-offscreen-32x32)
[65.451593] Starting subtest: cursor-offscreen-32x32
[65.500918] Subtest cursor-offscreen-32x32: SKIP (0.044s)
[65.769819] [003/133] (954s left) gem_exec_reloc (basic-gtt-read-noreloc)
[65.838323] Subtest basic-gtt-read-noreloc: SKIP (0.000s)
[65.914416] [004/133] (954s left) core_setmaster (master-drop-set-user)
[65.991883] Starting subtest: master-drop-set-user
[66.005410] Subtest master-drop-set-user: SUCCESS (0.014s)
[66.040592] [005/133] (954s left) gem_userptr_blits (invalid-null-pointer)
[66.109604] Starting subtest: invalid-null-pointer
[66.111687] Subtest invalid-null-pointer: SUCCESS (0.001s)
[66.258259] [006/133] (953s left) gem_exec_capture (capture-recoverable)
[66.319796] Starting subtest: capture-recoverable
[66.321992] Subtest capture-recoverable: SUCCESS (0.002s)
[66.429220] [007/133] (953s left) kms_flip (flip-vs-fences)
[66.526367] Starting subtest: flip-vs-fences
[66.529886] Subtest flip-vs-fences: SKIP (0.000s)
[66.631652] [008/133] (953s left) kms_async_flips (test-time-stamp)
[66.809422] Starting subtest: test-time-stamp
[67.189945] Starting dynamic subtest: pipe-A-eDP-1
[67.975967] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.784s)
[68.356847] Starting dynamic subtest: pipe-B-eDP-1
[69.115748] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.762s)
[69.484396] Starting dynamic subtest: pipe-C-eDP-1
[70.245442] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.764s)
[70.610729] Starting dynamic subtest: pipe-D-eDP-1
[71.367701] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.761s)
[71.370234] Subtest test-time-stamp: SUCCESS (4.558s)
[72.528113] [009/133] (947s left) gem_lmem_swapping (parallel-random-verify-ccs)
[72.574543] Subtest parallel-random-verify-ccs: SKIP (0.000s)
[72.609555] [010/133] (947s left) gem_exec_params (invalid-batch-start-offset)
[72.670066] Starting subtest: invalid-batch-start-offset
[72.672588] Subtest invalid-batch-start-offset: SUCCESS (0.002s)
[72.787201] [011/133] (947s left) gem_render_copy (yf-tiled-ccs-to-yf-tiled)
[72.845599] Starting subtest: yf-tiled-ccs-to-yf-tiled
[72.849977] Subtest yf-tiled-ccs-to-yf-tiled: SKIP (0.000s)
[73.025461] [012/133] (947s left) kms_big_fb (y-tiled-addfb-size-offset-overflow)
[73.126076] Starting subtest: y-tiled-addfb-size-offset-overflow
[73.130097] Subtest y-tiled-addfb-size-offset-overflow: SKIP (0.000s)
[73.207032] [013/133] (947s left) gem_render_copy (y-tiled-to-vebox-yf-tiled)
[73.264761] Starting subtest: y-tiled-to-vebox-yf-tiled
[73.269181] Subtest y-tiled-to-vebox-yf-tiled: SKIP (0.000s)
[73.443648] [014/133] (947s left) kms_draw_crc (draw-method-mmap-wc)
[73.536892] Starting subtest: draw-method-mmap-wc
[73.539042] Starting dynamic subtest: xrgb8888-untiled
[73.768613] Dynamic subtest xrgb8888-untiled: SUCCESS (0.233s)
[73.777334] Starting dynamic subtest: rgb565-untiled
[73.968432] Dynamic subtest rgb565-untiled: SUCCESS (0.200s)
[73.977113] Starting dynamic subtest: xrgb2101010-untiled
[74.180101] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.211s)
[74.189628] Starting dynamic subtest: xbgr16161616f-untiled
[74.390461] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.210s)
[74.397214] Starting dynamic subtest: xrgb8888-xtiled
[74.524098] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.133s)
[74.532438] Starting dynamic subtest: rgb565-xtiled
[74.645925] Dynamic subtest rgb565-xtiled: SUCCESS (0.122s)
[74.654487] Starting dynamic subtest: xrgb2101010-xtiled
[74.757209] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.111s)
[74.764476] Starting dynamic subtest: xbgr16161616f-xtiled
[74.890614] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (0.132s)
[74.898456] Starting dynamic subtest: xrgb8888-4tiled
[75.046040] Dynamic subtest xrgb8888-4tiled: SUCCESS (0.155s)
[75.053651] Starting dynamic subtest: rgb565-4tiled
[75.190674] Dynamic subtest rgb565-4tiled: SUCCESS (0.144s)
[75.202727] Starting dynamic subtest: xrgb2101010-4tiled
[75.345933] Dynamic subtest xrgb2101010-4tiled: SUCCESS (0.154s)
[75.353908] Starting dynamic subtest: xbgr16161616f-4tiled
[75.512509] Dynamic subtest xbgr16161616f-4tiled: SUCCESS (0.166s)
[75.514335] Subtest draw-method-mmap-wc: SUCCESS (1.978s)
[75.601208] [015/133] (944s left) kms_big_fb (linear-max-hw-stride-32bpp-rotate-180)
[75.706699] Starting subtest: linear-max-hw-stride-32bpp-rotate-180
[76.854105] Subtest linear-max-hw-stride-32bpp-rotate-180: SUCCESS (1.147s)
[76.968871] [016/133] (943s left) kms_plane_cursor (viewport)
[77.057500] Starting subtest: viewport
[77.061123] Starting dynamic subtest: pipe-A-eDP-1-size-64
[79.523705] Dynamic subtest pipe-A-eDP-1-size-64: SUCCESS (2.466s)
[79.581756] Starting dynamic subtest: pipe-A-eDP-1-size-128
[82.035627] Dynamic subtest pipe-A-eDP-1-size-128: SUCCESS (2.460s)
[82.096417] Starting dynamic subtest: pipe-A-eDP-1-size-256
[84.559957] Dynamic subtest pipe-A-eDP-1-size-256: SUCCESS (2.471s)
[84.906715] Starting dynamic subtest: pipe-B-eDP-1-size-64
[88.082438] Dynamic subtest pipe-B-eDP-1-size-64: SUCCESS (3.183s)
[88.140846] Starting dynamic subtest: pipe-B-eDP-1-size-128
[90.661202] Dynamic subtest pipe-B-eDP-1-size-128: SUCCESS (2.526s)
[90.723987] Starting dynamic subtest: pipe-B-eDP-1-size-256
[93.195551] Dynamic subtest pipe-B-eDP-1-size-256: SUCCESS (2.482s)
[93.544339] Starting dynamic subtest: pipe-C-eDP-1-size-64
[96.436158] Dynamic subtest pipe-C-eDP-1-size-64: SUCCESS (2.900s)
[96.470963] Starting dynamic subtest: pipe-C-eDP-1-size-128
[98.545589] Dynamic subtest pipe-C-eDP-1-size-128: SUCCESS (2.080s)
[98.582168] Starting dynamic subtest: pipe-C-eDP-1-size-256
[100.600842] Dynamic subtest pipe-C-eDP-1-size-256: SUCCESS (2.025s)
[100.938796] Starting dynamic subtest: pipe-D-eDP-1-size-64
[103.679087] Dynamic subtest pipe-D-eDP-1-size-64: SUCCESS (2.751s)
[103.714521] Starting dynamic subtest: pipe-D-eDP-1-size-128
[105.789083] Dynamic subtest pipe-D-eDP-1-size-128: SUCCESS (2.081s)
[105.825965] Starting dynamic subtest: pipe-D-eDP-1-size-256
[107.889696] Dynamic subtest pipe-D-eDP-1-size-256: SUCCESS (2.069s)
[108.209284] Subtest viewport: SUCCESS (31.152s)
[109.062982] [017/133] (911s left) gem_userptr_blits (stress-purge)
[109.130881] Starting subtest: stress-purge
[114.538691] Subtest stress-purge: SUCCESS (5.411s)
[114.689061] [018/133] (905s left) gem_exec_balancer (bonded-true-hang)
[114.989225] Starting subtest: bonded-true-hang
[114.994928] Subtest bonded-true-hang: SKIP (0.000s)
[115.086020] [019/133] (905s left) kms_plane_scaling (plane-downscale-factor-0-75-with-rotation)
[115.194343] Starting subtest: plane-downscale-factor-0-75-with-rotation
[115.196676] Starting dynamic subtest: pipe-A
[115.422307] Dynamic subtest pipe-A: SUCCESS (0.230s)
[115.430364] Starting dynamic subtest: pipe-B
[116.731760] Dynamic subtest pipe-B: SUCCESS (1.308s)
[116.744305] Starting dynamic subtest: pipe-C
[118.091032] Dynamic subtest pipe-C: SUCCESS (1.357s)
[118.098865] Starting dynamic subtest: pipe-D
[119.403172] Dynamic subtest pipe-D: SUCCESS (1.311s)
[119.405332] Subtest plane-downscale-factor-0-75-with-rotation: SUCCESS (4.212s)
[120.571737] [020/133] (900s left) syncobj_timeline (single-wait-available-submitted)
[120.643965] Starting subtest: single-wait-available-submitted
[120.646519] Subtest single-wait-available-submitted: SUCCESS (0.000s)
[120.715177] [021/133] (900s left) kms_chamelium_edid (dp-edid-change-during-suspend)
[121.105199] Subtest dp-edid-change-during-suspend: SKIP (0.000s)
[121.876579] [022/133] (898s left) kms_frontbuffer_tracking (psr-1p-primscrn-indfb-plflip-blt)
[121.970342] Starting subtest: psr-1p-primscrn-indfb-plflip-blt
[129.426946] Subtest psr-1p-primscrn-indfb-plflip-blt: SUCCESS (7.460s)
[129.575794] [023/133] (891s left) kms_display_modes (extended-mode-basic)
[129.672125] Starting subtest: extended-mode-basic
[129.676595] Subtest extended-mode-basic: SKIP (0.000s)
[129.717472] [024/133] (891s left) kms_content_protection (dp-mst-type-0)
[129.859236] Starting subtest: dp-mst-type-0
[129.863727] Subtest dp-mst-type-0: SKIP (0.000s)
[129.976925] [025/133] (890s left) kms_setmode (invalid-clone-single-crtc-stealing)
[130.027827] Starting subtest: invalid-clone-single-crtc-stealing
[130.034563] Subtest invalid-clone-single-crtc-stealing: SKIP (0.000s)
[130.122648] [026/133] (890s left) kms_psr (pr-suspend)
[130.213779] Starting subtest: pr-suspend
[130.218124] Subtest pr-suspend: SKIP (0.000s)
[130.283860] [027/133] (890s left) gem_tiled_partial_pwrite_pread (writes)
[130.350325] Subtest writes: SKIP (0.000s)
[130.438562] [028/133] (890s left) gem_softpin (evict-prime-sanity-check)
[130.516447] Starting subtest: evict-prime-sanity-check
[130.518275] Starting dynamic subtest: rcs0
[131.659900] Dynamic subtest rcs0: SUCCESS (1.145s)
[131.670264] Starting dynamic subtest: bcs0
[132.796814] Dynamic subtest bcs0: SUCCESS (1.135s)
[132.807318] Starting dynamic subtest: vcs0
[135.891067] Dynamic subtest vcs0: SUCCESS (3.091s)
[135.901775] Starting dynamic subtest: vcs1
[137.851053] Dynamic subtest vcs1: SUCCESS (1.957s)
[137.861882] Starting dynamic subtest: vecs0
[139.918181] Dynamic subtest vecs0: SUCCESS (2.065s)
[139.929216] Starting dynamic subtest: ccs0
[141.052096] Dynamic subtest ccs0: SUCCESS (1.133s)
[141.063074] Starting dynamic subtest: all
[142.175901] Dynamic subtest all: SUCCESS (1.121s)
[142.178678] Subtest evict-prime-sanity-check: SUCCESS (11.662s)
[142.256628] [029/133] (878s left) kms_flip (bo-too-big-interruptible)
[142.366179] Starting subtest: bo-too-big-interruptible
[142.368381] Starting dynamic subtest: A-eDP1
[143.669218] Dynamic subtest A-eDP1: SUCCESS (1.302s)
[143.681787] Starting dynamic subtest: B-eDP1
[144.886766] Dynamic subtest B-eDP1: SUCCESS (1.215s)
[144.895613] Starting dynamic subtest: C-eDP1
[146.129558] Dynamic subtest C-eDP1: SUCCESS (1.242s)
[146.138627] Starting dynamic subtest: D-eDP1
[147.366889] Dynamic subtest D-eDP1: SUCCESS (1.236s)
[147.373573] Subtest bo-too-big-interruptible: SUCCESS (5.008s)
[148.567294] [030/133] (872s left) sriov_basic (enable-vfs-autoprobe-off)
[148.626670] Starting subtest: enable-vfs-autoprobe-off
[148.628954] Starting dynamic subtest: numvfs-1
[148.707091] Dynamic subtest numvfs-1: FAIL (0.029s)
[148.716754] Starting dynamic subtest: numvfs-2
[148.788643] Dynamic subtest numvfs-2: FAIL (0.003s)
[148.797783] Starting dynamic subtest: numvfs-3
[148.873732] Dynamic subtest numvfs-3: FAIL (0.003s)
[148.883251] Starting dynamic subtest: numvfs-4
[148.954684] Dynamic subtest numvfs-4: FAIL (0.003s)
[148.963827] Starting dynamic subtest: numvfs-5
[149.036839] Dynamic subtest numvfs-5: FAIL (0.004s)
[149.045485] Starting dynamic subtest: numvfs-6
[149.119340] Dynamic subtest numvfs-6: FAIL (0.003s)
[149.129246] Starting dynamic subtest: numvfs-7
[149.202862] Dynamic subtest numvfs-7: FAIL (0.004s)
[149.211623] Starting dynamic subtest: numvfs-random
[149.281466] Dynamic subtest numvfs-random: FAIL (0.003s)
[149.291306] Starting dynamic subtest: numvfs-all
[149.360737] Dynamic subtest numvfs-all: FAIL (0.508s)
[149.362949] Subtest enable-vfs-autoprobe-off: FAIL (0.569s)
[149.397448] [031/133] (871s left) kms_cursor_legacy (cursorb-vs-flipa-atomic)
[149.519082] Starting subtest: cursorB-vs-flipA-atomic
[149.522745] Subtest cursorB-vs-flipA-atomic: SKIP (0.001s)
[149.662171] [032/133] (871s left) kms_atomic_interruptible (atomic-setmode)
[149.754951] Starting subtest: atomic-setmode
[149.756804] Starting dynamic subtest: pipe-A-eDP-1
[156.625489] Dynamic subtest pipe-A-eDP-1: SUCCESS (6.869s)
[156.627765] Subtest atomic-setmode: SUCCESS (6.871s)
[157.432965] [033/133] (863s left) gem_lmem_swapping (basic)
[157.476704] Subtest basic: SKIP (0.000s)
[157.514670] [034/133] (863s left) i915_pm_rpm (gem-execbuf-stress-pc8)
[159.036475] Starting subtest: gem-execbuf-stress-pc8
[159.084527] Subtest gem-execbuf-stress-pc8: SKIP (0.047s)
[159.757759] [035/133] (861s left) kms_pm_lpsp (kms-lpsp)
[160.866514] Starting subtest: kms-lpsp
[160.868833] Starting dynamic subtest: pipe-A-eDP-1
[161.017572] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.155s)
[161.314972] Subtest kms-lpsp: SUCCESS (0.451s)
[162.185222] [036/133] (859s left) gem_render_copy (y-tiled-ccs-to-linear)
[162.245333] Starting subtest: y-tiled-ccs-to-linear
[162.249568] Subtest y-tiled-ccs-to-linear: SKIP (0.000s)
[162.446548] [037/133] (858s left) gem_workarounds (suspend-resume)
[162.508827] Starting subtest: suspend-resume
[178.666758] Subtest suspend-resume: SUCCESS (1.301s)
[178.822479] [038/133] (842s left) syncobj_wait (wait-delayed-signal)
[178.895775] Starting subtest: wait-delayed-signal
[178.997926] Subtest wait-delayed-signal: SUCCESS (0.103s)
[179.092008] [039/133] (842s left) i915_hangman (gt-error-state-capture)
[179.165382] Starting subtest: gt-error-state-capture
[179.167659] Starting dynamic subtest: rcs0
[190.716549] Dynamic subtest rcs0: SUCCESS (11.550s)
[190.728710] Starting dynamic subtest: bcs0
[202.747376] Dynamic subtest bcs0: SUCCESS (12.027s)
[202.759088] Starting dynamic subtest: vcs0
[214.716436] Dynamic subtest vcs0: SUCCESS (11.965s)
[214.729011] Starting dynamic subtest: vcs1
[226.684429] Dynamic subtest vcs1: SUCCESS (11.964s)
[226.697875] Starting dynamic subtest: vecs0
[237.692470] Dynamic subtest vecs0: SUCCESS (11.004s)
[237.704570] Starting dynamic subtest: ccs0
[249.724238] Dynamic subtest ccs0: SUCCESS (12.028s)
[249.726972] Subtest gt-error-state-capture: SUCCESS (70.555s)
[249.867615] [040/133] (771s left) kms_color_pipeline (plane-lut1d)
[249.964770] Starting subtest: plane-lut1d
[250.090152] Starting dynamic subtest: pipe-A-plane-0
[250.244418] Dynamic subtest pipe-A-plane-0: SUCCESS (0.155s)
[250.256332] Starting dynamic subtest: pipe-A-plane-1
[250.378097] Dynamic subtest pipe-A-plane-1: SUCCESS (0.133s)
[250.390039] Starting dynamic subtest: pipe-A-plane-2
[250.521994] Dynamic subtest pipe-A-plane-2: SUCCESS (0.144s)
[251.724297] Starting dynamic subtest: pipe-B-plane-0
[251.917843] Dynamic subtest pipe-B-plane-0: SUCCESS (0.200s)
[251.932424] Starting dynamic subtest: pipe-B-plane-1
[252.050994] Dynamic subtest pipe-B-plane-1: SUCCESS (0.133s)
[252.059969] Starting dynamic subtest: pipe-B-plane-2
[252.240938] Dynamic subtest pipe-B-plane-2: SUCCESS (0.188s)
[253.454696] Starting dynamic subtest: pipe-C-plane-0
[253.580526] Dynamic subtest pipe-C-plane-0: SUCCESS (0.133s)
[253.589789] Starting dynamic subtest: pipe-C-plane-1
[253.724808] Dynamic subtest pipe-C-plane-1: SUCCESS (0.144s)
[253.734124] Starting dynamic subtest: pipe-C-plane-2
[253.869409] Dynamic subtest pipe-C-plane-2: SUCCESS (0.144s)
[255.093398] Starting dynamic subtest: pipe-D-plane-0
[255.263834] Dynamic subtest pipe-D-plane-0: SUCCESS (0.178s)
[255.273120] Starting dynamic subtest: pipe-D-plane-1
[255.408245] Dynamic subtest pipe-D-plane-1: SUCCESS (0.142s)
[255.420469] Starting dynamic subtest: pipe-D-plane-2
[255.563838] Dynamic subtest pipe-D-plane-2: SUCCESS (0.155s)
[255.849898] Subtest plane-lut1d: SUCCESS (5.886s)
[256.656357] [041/133] (764s left) kms_pipe_b_c_ivb (from-pipe-c-to-b-with-3-lanes)
[256.714704] Subtest from-pipe-C-to-B-with-3-lanes: SKIP (0.000s)
[256.765951] [042/133] (764s left) kms_flip_scaled_crc (flip-64bpp-xtile-to-32bpp-xtile-downscaling)
[256.872939] Starting subtest: flip-64bpp-xtile-to-32bpp-xtile-downscaling
[256.875121] Starting dynamic subtest: pipe-A-default-mode
[258.009675] Dynamic subtest pipe-A-default-mode: SKIP (1.136s)
[258.014122] Subtest flip-64bpp-xtile-to-32bpp-xtile-downscaling: SKIP (1.137s)
[258.133771] [043/133] (763s left) kms_invalid_mode (bad-vsync-end)
[258.233312] Starting subtest: bad-vsync-end
[258.235428] Starting dynamic subtest: pipe-A-eDP-1
[258.517961] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.286s)
[258.526775] Starting dynamic subtest: pipe-B-eDP-1
[258.528910] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[258.537045] Starting dynamic subtest: pipe-C-eDP-1
[258.539189] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[258.546996] Starting dynamic subtest: pipe-D-eDP-1
[258.549222] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[258.551335] Subtest bad-vsync-end: SUCCESS (0.292s)
[259.308780] [044/133] (762s left) gem_ctx_persistence (engines-queued)
[259.365859] Starting subtest: engines-queued
[259.367976] Starting dynamic subtest: rcs0
[259.432001] Dynamic subtest rcs0: SUCCESS (0.068s)
[259.443529] Starting dynamic subtest: bcs0
[259.452572] Dynamic subtest bcs0: SUCCESS (0.019s)
[259.461201] Starting dynamic subtest: vcs0
[260.735551] Dynamic subtest vcs0: SUCCESS (1.280s)
[260.747314] Starting dynamic subtest: vcs1
[262.716715] Dynamic subtest vcs1: SUCCESS (1.978s)
[262.728253] Starting dynamic subtest: vecs0
[264.763479] Dynamic subtest vecs0: SUCCESS (2.043s)
[264.775101] Starting dynamic subtest: ccs0
[264.953685] Dynamic subtest ccs0: SUCCESS (0.189s)
[264.956134] Subtest engines-queued: SUCCESS (5.590s)
[265.071113] [045/133] (756s left) perf_pmu (render-node-busy)
[265.137889] Starting subtest: render-node-busy
[265.140262] Starting dynamic subtest: rcs0
[265.724507] Dynamic subtest rcs0: SUCCESS (0.586s)
[265.736625] Starting dynamic subtest: bcs0
[266.287313] Dynamic subtest bcs0: SUCCESS (0.559s)
[266.298881] Starting dynamic subtest: vcs0
[267.742460] Dynamic subtest vcs0: SUCCESS (1.453s)
[267.754997] Starting dynamic subtest: vcs1
[269.791832] Dynamic subtest vcs1: SUCCESS (2.046s)
[269.803900] Starting dynamic subtest: vecs0
[271.774456] Dynamic subtest vecs0: SUCCESS (1.979s)
[271.787125] Starting dynamic subtest: ccs0
[272.333610] Dynamic subtest ccs0: SUCCESS (0.558s)
[272.336144] Subtest render-node-busy: SUCCESS (7.196s)
[272.410476] [046/133] (749s left) kms_vrr (seamless-rr-switch-vrr)
[272.511280] Starting subtest: seamless-rr-switch-vrr
[272.517544] Subtest seamless-rr-switch-vrr: SKIP (0.000s)
[272.583373] [047/133] (749s left) kms_hdmi_inject (inject-audio)
[272.935437] Starting subtest: inject-audio
[273.209847] Subtest inject-audio: SUCCESS (0.276s)
[273.768765] [048/133] (748s left) kms_flip (single-buffer-flip-vs-dpms-off-vs-modeset-interruptible)
[273.866355] Starting subtest: single-buffer-flip-vs-dpms-off-vs-modeset-interruptible
[273.868646] Starting dynamic subtest: A-eDP1
[277.470716] Dynamic subtest A-eDP1: SUCCESS (3.601s)
[277.479722] Starting dynamic subtest: B-eDP1
[280.668484] Dynamic subtest B-eDP1: SUCCESS (3.195s)
[280.678890] Starting dynamic subtest: C-eDP1
[283.763336] Dynamic subtest C-eDP1: SUCCESS (3.095s)
[283.773881] Starting dynamic subtest: D-eDP1
[286.889949] Dynamic subtest D-eDP1: SUCCESS (3.124s)
[286.892332] Subtest single-buffer-flip-vs-dpms-off-vs-modeset-interruptible: SUCCESS (13.023s)
[287.683921] [049/133] (734s left) vgem_basic (dmabuf-export)
[287.797942] Starting subtest: dmabuf-export
[287.834786] Subtest dmabuf-export: SUCCESS (0.039s)
[287.944434] [FACT vgem_basic (dmabuf-export)] new: kernel.kmod_is_loaded.vgem: true
[287.948756] [050/133] (733s left) gem_exec_params (no-bsd)
[288.010419] Starting subtest: no-bsd
[288.012451] Subtest no-bsd: SUCCESS (0.002s)
[289.828511] [051/133] (732s left) syncobj_timeline (invalid-single-wait-all-unsubmitted)
[289.880091] Starting subtest: invalid-single-wait-all-unsubmitted
[289.882226] Subtest invalid-single-wait-all-unsubmitted: SUCCESS (0.000s)
[289.977773] [052/133] (732s left) gem_exec_fence (keep-in-fence)
[290.158108] Starting subtest: keep-in-fence
[290.160240] Starting dynamic subtest: rcs0
[290.211110] Dynamic subtest rcs0: SUCCESS (0.055s)
[290.225595] Starting dynamic subtest: bcs0
[290.268542] Dynamic subtest bcs0: SUCCESS (0.055s)
[290.279645] Starting dynamic subtest: vcs0
[291.743761] Dynamic subtest vcs0: SUCCESS (1.471s)
[291.756364] Starting dynamic subtest: vcs1
[293.789820] Dynamic subtest vcs1: SUCCESS (2.044s)
[293.802833] Starting dynamic subtest: vecs0
[295.774111] Dynamic subtest vecs0: SUCCESS (1.981s)
[295.786541] Starting dynamic subtest: ccs0
[296.022646] Dynamic subtest ccs0: SUCCESS (0.247s)
[296.025117] Subtest keep-in-fence: SUCCESS (5.868s)
[297.831571] [053/133] (724s left) vgem_basic (second-client)
[297.878284] Starting subtest: second-client
[297.900863] Subtest second-client: SUCCESS (0.022s)
[297.963284] [054/133] (724s left) gen9_exec_parse (cmd-crossing-page)
[298.021651] Subtest cmd-crossing-page: SKIP (0.000s)
[298.098933] [055/133] (724s left) kms_vblank (query-busy-hang)
[298.196880] Starting subtest: query-busy-hang
[298.199158] Starting dynamic subtest: pipe-A-eDP-1
[324.509404] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.310s)
[324.524985] Starting dynamic subtest: pipe-D-eDP-1
[349.531891] Dynamic subtest pipe-D-eDP-1: SUCCESS (25.020s)
[349.534378] Subtest query-busy-hang: SUCCESS (51.334s)
[350.345218] [056/133] (671s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-pwrite)
[350.437256] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-pwrite
[350.441287] Subtest fbc-2p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[350.533747] [057/133] (671s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-0-async-flip)
[350.629693] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-0-async-flip
[350.634088] Subtest yf-tiled-max-hw-stride-64bpp-rotate-0-async-flip: SKIP (0.000s)
[350.714687] [058/133] (671s left) kms_cursor_crc (cursor-random-512x170)
[351.044053] Starting subtest: cursor-random-512x170
[351.048428] Subtest cursor-random-512x170: SKIP (0.001s)
[351.192584] [059/133] (671s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-move)
[351.286529] Starting subtest: fbc-1p-primscrn-cur-indfb-move
[355.286113] Subtest fbc-1p-primscrn-cur-indfb-move: SUCCESS (4.002s)
[356.440459] [060/133] (665s left) kms_big_fb (4-tiled-32bpp-rotate-0)
[356.554284] Starting subtest: 4-tiled-32bpp-rotate-0
[357.968825] Subtest 4-tiled-32bpp-rotate-0: SUCCESS (1.413s)
[358.103655] [061/133] (664s left) kms_cursor_crc (cursor-sliding-64x21)
[358.313776] Starting subtest: cursor-sliding-64x21
[358.361292] Subtest cursor-sliding-64x21: SKIP (0.043s)
[358.611350] [062/133] (663s left) kms_plane_scaling (planes-downscale-factor-0-75)
[358.704543] Starting subtest: planes-downscale-factor-0-75
[358.706420] Starting dynamic subtest: pipe-A
[358.725925] Dynamic subtest pipe-A: SKIP (0.019s)
[358.738505] Starting dynamic subtest: pipe-B
[358.760626] Dynamic subtest pipe-B: SKIP (0.034s)
[358.769934] Starting dynamic subtest: pipe-C
[358.794076] Dynamic subtest pipe-C: SKIP (0.031s)
[358.804652] Starting dynamic subtest: pipe-D
[358.827621] Dynamic subtest pipe-D: SKIP (0.031s)
[358.830916] Subtest planes-downscale-factor-0-75: SKIP (0.119s)
[358.949303] [063/133] (663s left) kms_chamelium_hpd (common-hpd-after-suspend)
[359.331497] Subtest common-hpd-after-suspend: SKIP (0.000s)
[360.134240] [064/133] (662s left) syncobj_eventfd (timeline-wait-before-signal)
[360.185934] Starting subtest: timeline-wait-before-signal
[360.215395] Subtest timeline-wait-before-signal: SUCCESS (0.031s)
[360.299648] [065/133] (662s left) kms_ccs (crc-sprite-planes-basic-4-tiled-mtl-rc-ccs-cc)
[360.387003] Starting subtest: crc-sprite-planes-basic-4-tiled-mtl-rc-ccs-cc
[360.389233] Starting dynamic subtest: pipe-A-eDP-1
[360.835027] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.418s)
[360.846880] Starting dynamic subtest: pipe-B-eDP-1
[362.259913] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.424s)
[362.271915] Starting dynamic subtest: pipe-C-eDP-1
[363.655957] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.394s)
[363.668140] Starting dynamic subtest: pipe-D-eDP-1
[364.992448] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.336s)
[364.994649] Subtest crc-sprite-planes-basic-4-tiled-mtl-rc-ccs-cc: SUCCESS (4.578s)
[366.187033] [066/133] (656s left) gem_exec_whisper (basic-normal-all)
[366.253846] Starting subtest: basic-normal-all
[368.643387] Subtest basic-normal-all: SUCCESS (2.387s)
[368.827459] [067/133] (653s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-fullscreen)
[368.925314] Starting subtest: psr-1p-primscrn-spr-indfb-fullscreen
[375.567552] Subtest psr-1p-primscrn-spr-indfb-fullscreen: SUCCESS (6.644s)
[375.714989] [068/133] (646s left) syncobj_timeline (wait-for-submit-complex)
[375.771012] Starting subtest: wait-for-submit-complex
[375.832603] Subtest wait-for-submit-complex: SUCCESS (0.062s)
[375.906977] [069/133] (646s left) kms_addfb_basic (basic-x-tiled-legacy)
[375.955692] Starting subtest: basic-x-tiled-legacy
[375.959736] Subtest basic-x-tiled-legacy: SKIP (0.000s)
[376.095664] [070/133] (646s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-blt)
[376.180309] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-blt
[376.184563] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[376.281843] [071/133] (646s left) gem_pread (self)
[376.334651] Subtest self: SKIP (0.000s)
[376.388246] [072/133] (646s left) kms_busy (extended-modeset-hang-oldfb-with-reset)
[376.480840] Starting subtest: extended-modeset-hang-oldfb-with-reset
[376.483209] Starting dynamic subtest: pipe-A
[388.364877] Dynamic subtest pipe-A: SUCCESS (11.879s)
[388.374795] Starting dynamic subtest: pipe-D
[400.845458] Dynamic subtest pipe-D: SUCCESS (12.479s)
[400.847745] Subtest extended-modeset-hang-oldfb-with-reset: SUCCESS (24.363s)
[401.656460] [073/133] (621s left) kms_cursor_legacy (2x-long-cursor-vs-flip-atomic)
[401.779785] Starting subtest: 2x-long-cursor-vs-flip-atomic
[401.784358] Subtest 2x-long-cursor-vs-flip-atomic: SKIP (0.001s)
[401.932856] [074/133] (620s left) gem_exec_schedule (submit-late-slice)
[401.993874] Starting subtest: submit-late-slice
[401.996146] Starting dynamic subtest: rcs0
[402.031672] Dynamic subtest rcs0: SUCCESS (0.043s)
[402.044042] Starting dynamic subtest: bcs0
[402.067338] Dynamic subtest bcs0: SUCCESS (0.035s)
[402.077447] Starting dynamic subtest: vcs0
[402.102522] Dynamic subtest vcs0: SUCCESS (0.034s)
[402.112873] Starting dynamic subtest: vcs1
[402.138630] Dynamic subtest vcs1: SUCCESS (0.035s)
[402.148594] Starting dynamic subtest: vecs0
[402.176773] Dynamic subtest vecs0: SUCCESS (0.037s)
[402.189727] Starting dynamic subtest: ccs0
[402.217640] Dynamic subtest ccs0: SUCCESS (0.040s)
[402.219821] Subtest submit-late-slice: SUCCESS (0.230s)
[403.820310] [075/133] (619s left) kms_force_connector_basic (force-load-detect)
[403.907102] Starting subtest: force-load-detect
[403.911698] Subtest force-load-detect: SKIP (0.000s)
[404.020792] [076/133] (618s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-mmap-wc)
[404.120370] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-mmap-wc
[408.081449] Subtest fbc-1p-offscreen-pri-indfb-draw-mmap-wc: SUCCESS (3.965s)
[409.244295] [077/133] (613s left) kms_ccs (random-ccs-data-4-tiled-mtl-mc-ccs)
[409.345528] Starting subtest: random-ccs-data-4-tiled-mtl-mc-ccs
[409.347429] Starting dynamic subtest: pipe-A-eDP-1
[410.543527] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.198s)
[410.553248] Starting dynamic subtest: pipe-B-eDP-1
[412.868706] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.325s)
[412.879205] Starting dynamic subtest: pipe-C-eDP-1
[415.207947] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.338s)
[415.220034] Starting dynamic subtest: pipe-D-eDP-1
[417.521146] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.310s)
[417.523492] Subtest random-ccs-data-4-tiled-mtl-mc-ccs: SUCCESS (8.178s)
[418.664251] [078/133] (604s left) gem_caching (reads)
[418.725381] Subtest reads: SKIP (0.000s)
[418.795201] [079/133] (604s left) kms_psr_stress_test (invalidate-primary-flip-overlay)
[418.895378] Starting subtest: invalidate-primary-flip-overlay
[429.685695] Subtest invalidate-primary-flip-overlay: SUCCESS (10.792s)
[429.787791] [080/133] (593s left) gem_exec_params (invalid-ring)
[429.838525] Starting subtest: invalid-ring
[429.840211] Subtest invalid-ring: SUCCESS (0.000s)
[429.930048] [081/133] (593s left) kms_frontbuffer_tracking (psr-2p-scndscrn-indfb-msflip-blt)
[430.030827] Starting subtest: psr-2p-scndscrn-indfb-msflip-blt
[430.034239] Subtest psr-2p-scndscrn-indfb-msflip-blt: SKIP (0.000s)
[430.124881] [082/133] (593s left) syncobj_timeline (multi-wait-for-submit-available-unsubmitted-submitted-signa
[430.192126] Starting subtest: multi-wait-for-submit-available-unsubmitted-submitted-signaled
[430.194214] Subtest multi-wait-for-submit-available-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[430.318837] [083/133] (592s left) kms_plane (pixel-format-4-tiled-mtl-mc-ccs-modifier-source-clamping)
[430.415638] Starting subtest: pixel-format-4-tiled-mtl-mc-ccs-modifier-source-clamping
[430.442103] Starting dynamic subtest: pipe-A-plane-0
[430.875136] Dynamic subtest pipe-A-plane-0: SUCCESS (0.433s)
[430.884682] Starting dynamic subtest: pipe-A-plane-3
[431.143128] Dynamic subtest pipe-A-plane-3: SUCCESS (0.266s)
[432.241820] Starting dynamic subtest: pipe-B-plane-0
[432.678308] Dynamic subtest pipe-B-plane-0: SUCCESS (0.444s)
[432.687625] Starting dynamic subtest: pipe-B-plane-3
[432.933942] Dynamic subtest pipe-B-plane-3: SUCCESS (0.253s)
[433.243097] Subtest pixel-format-4-tiled-mtl-mc-ccs-modifier-source-clamping: SUCCESS (2.828s)
[434.110322] [084/133] (589s left) kms_psr2_sf (fbc-psr2-cursor-plane-move-continuous-exceed-sf)
[434.211192] Starting subtest: fbc-psr2-cursor-plane-move-continuous-exceed-sf
[434.213495] Starting dynamic subtest: pipe-A-eDP-1
[434.286826] Dynamic subtest pipe-A-eDP-1: SKIP (0.077s)
[434.298848] Starting dynamic subtest: pipe-B-eDP-1
[435.385436] Dynamic subtest pipe-B-eDP-1: SKIP (1.096s)
[435.389941] Subtest fbc-psr2-cursor-plane-move-continuous-exceed-sf: SKIP (1.176s)
[436.560854] [085/133] (586s left) gem_partial_pwrite_pread (writes-after-reads-snoop)
[436.618741] Subtest writes-after-reads-snoop: SKIP (0.000s)
[436.691717] [086/133] (586s left) kms_vrr (flip-dpms)
[436.778231] Starting subtest: flip-dpms
[436.784159] Subtest flip-dpms: SKIP (0.000s)
[436.869184] [087/133] (586s left) gem_render_copy (y-tiled-ccs-to-y-tiled)
[436.928178] Starting subtest: y-tiled-ccs-to-y-tiled
[436.932272] Subtest y-tiled-ccs-to-y-tiled: SKIP (0.000s)
[437.126442] [088/133] (586s left) gem_ctx_engines (execute-allforone)
[437.193769] Starting subtest: execute-allforone
[437.208842] Subtest execute-allforone: SUCCESS (0.015s)
[438.831021] [089/133] (584s left) kms_psr (fbc-psr2-sprite-mmap-gtt)
[438.931375] Starting subtest: fbc-psr2-sprite-mmap-gtt
[438.933662] Starting dynamic subtest: eDP-1
[438.938112] Dynamic subtest eDP-1: SKIP (0.000s)
[438.942463] Subtest fbc-psr2-sprite-mmap-gtt: SKIP (0.001s)
[439.003357] [090/133] (584s left) api_intel_bb (destroy-bb)
[439.056406] Starting subtest: destroy-bb
[439.064880] Subtest destroy-bb: SUCCESS (0.008s)
[439.177564] [091/133] (584s left) kms_flip (flip-vs-dpms-off-vs-modeset-interruptible)
[439.268198] Starting subtest: flip-vs-dpms-off-vs-modeset-interruptible
[439.270545] Starting dynamic subtest: A-eDP1
[442.877785] Dynamic subtest A-eDP1: SUCCESS (3.607s)
[442.887989] Starting dynamic subtest: B-eDP1
[446.084289] Dynamic subtest B-eDP1: SUCCESS (3.205s)
[446.095462] Starting dynamic subtest: C-eDP1
[449.204956] Dynamic subtest C-eDP1: SUCCESS (3.119s)
[449.215327] Starting dynamic subtest: D-eDP1
[452.324984] Dynamic subtest D-eDP1: SUCCESS (3.121s)
[452.327335] Subtest flip-vs-dpms-off-vs-modeset-interruptible: SUCCESS (13.058s)
[453.116216] [092/133] (570s left) gem_basic (multigpu-create-close)
[453.180573] Starting subtest: multigpu-create-close
[453.184463] Subtest multigpu-create-close: SKIP (0.000s)
[453.277681] [093/133] (570s left) kms_lease (cursor-implicit-plane)
[453.370053] Starting subtest: cursor-implicit-plane
[453.372523] Starting dynamic subtest: pipe-A-eDP-1
[453.842616] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.471s)
[453.853115] Starting dynamic subtest: pipe-B-eDP-1
[454.934776] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.091s)
[454.945422] Starting dynamic subtest: pipe-C-eDP-1
[456.051288] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.115s)
[456.061980] Starting dynamic subtest: pipe-D-eDP-1
[457.180817] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.126s)
[457.183102] Subtest cursor-implicit-plane: SUCCESS (3.810s)
[458.035238] [094/133] (565s left) syncobj_timeline (invalid-multi-wait-all-unsubmitted)
[458.087923] Starting subtest: invalid-multi-wait-all-unsubmitted
[458.090235] Subtest invalid-multi-wait-all-unsubmitted: SUCCESS (0.000s)
[458.177953] [095/133] (565s left) i915_drm_fdinfo (all-busy-idle-check-all)
[458.223799] Starting subtest: all-busy-idle-check-all
[458.227935] Subtest all-busy-idle-check-all: SKIP (0.004s)
[458.300132] [096/133] (565s left) kms_ccs (crc-primary-suspend-4-tiled-mtl-rc-ccs-cc)
[458.410259] Starting subtest: crc-primary-suspend-4-tiled-mtl-rc-ccs-cc
[458.412442] Starting dynamic subtest: pipe-A-eDP-1
[474.872116] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.419s)
[474.883066] Starting dynamic subtest: pipe-B-eDP-1
[491.822868] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.423s)
[491.833343] Starting dynamic subtest: pipe-C-eDP-1
[508.830197] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.349s)
[508.839913] Starting dynamic subtest: pipe-D-eDP-1
[525.825671] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.346s)
[525.828098] Subtest crc-primary-suspend-4-tiled-mtl-rc-ccs-cc: SUCCESS (8.543s)
[527.050795] [097/133] (496s left) gem_mmap_offset (partial-remap)
[527.122679] Starting subtest: partial-remap
[527.125688] Starting dynamic subtest: smem0
[527.136603] Dynamic subtest smem0: SUCCESS (0.004s)
[527.139212] Subtest partial-remap: SUCCESS (0.005s)
[527.247480] [098/133] (496s left) kms_psr (fbc-psr2-cursor-blt)
[527.355401] Starting subtest: fbc-psr2-cursor-blt
[527.357701] Starting dynamic subtest: eDP-1
[527.362455] Dynamic subtest eDP-1: SKIP (0.000s)
[527.366917] Subtest fbc-psr2-cursor-blt: SKIP (0.001s)
[527.428980] [099/133] (496s left) gem_ctx_shared (q-out-order)
[527.492116] Starting subtest: Q-out-order
[527.494358] Starting dynamic subtest: rcs0
[527.607233] Dynamic subtest rcs0: SUCCESS (0.116s)
[527.620006] Starting dynamic subtest: vcs0
[527.703074] Dynamic subtest vcs0: SUCCESS (0.096s)
[527.721385] Starting dynamic subtest: vcs1
[527.786131] Dynamic subtest vcs1: SUCCESS (0.082s)
[527.805788] Starting dynamic subtest: vecs0
[527.870526] Dynamic subtest vecs0: SUCCESS (0.082s)
[527.887798] Starting dynamic subtest: ccs0
[527.953313] Dynamic subtest ccs0: SUCCESS (0.082s)
[527.955939] Subtest Q-out-order: SUCCESS (0.464s)
[529.702096] [100/133] (494s left) kms_frontbuffer_tracking (psr-2p-primscrn-shrfb-msflip-blt)
[529.797442] Starting subtest: psr-2p-primscrn-shrfb-msflip-blt
[529.802695] Subtest psr-2p-primscrn-shrfb-msflip-blt: SKIP (0.000s)
[529.885001] [101/133] (494s left) sw_sync (alloc_fence_invalid_timeline)
[529.922513] Starting subtest: alloc_fence_invalid_timeline
[529.925513] Subtest alloc_fence_invalid_timeline: SUCCESS (0.000s)
[529.974037] [102/133] (494s left) kms_flip_scaled_crc (flip-32bpp-xtile-to-64bpp-xtile-upscaling)
[530.065388] Starting subtest: flip-32bpp-xtile-to-64bpp-xtile-upscaling
[530.067953] Starting dynamic subtest: pipe-A-default-mode
[532.824058] Dynamic subtest pipe-A-default-mode: SUCCESS (2.754s)
[532.826939] Subtest flip-32bpp-xtile-to-64bpp-xtile-upscaling: SUCCESS (2.755s)
[533.658644] [103/133] (490s left) kms_big_fb (linear-64bpp-rotate-270)
[533.765226] Starting subtest: linear-64bpp-rotate-270
[533.785435] Subtest linear-64bpp-rotate-270: SKIP (0.019s)
[533.909336] [104/133] (490s left) gem_workarounds (reset-fd)
[533.979664] Starting subtest: reset-fd
[534.158964] Subtest reset-fd: SUCCESS (0.179s)
[534.289428] [105/133] (489s left) kms_flip (2x-single-buffer-flip-vs-dpms-off-vs-modeset)
[534.376280] Starting subtest: 2x-single-buffer-flip-vs-dpms-off-vs-modeset
[534.386677] Subtest 2x-single-buffer-flip-vs-dpms-off-vs-modeset: SKIP (0.010s)
[534.464595] [106/133] (489s left) kms_atomic_transition (plane-all-transition-nonblocking-fencing)
[534.563003] Starting subtest: plane-all-transition-nonblocking-fencing
[534.565278] Starting dynamic subtest: pipe-A-eDP-1
[537.058171] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.495s)
[537.379644] Starting dynamic subtest: pipe-B-eDP-1
[540.597138] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.228s)
[540.901528] Subtest plane-all-transition-nonblocking-fencing: SUCCESS (6.334s)
[541.719025] [107/133] (482s left) kms_frontbuffer_tracking (fbcpsr-shrfb-scaledprimary)
[541.820995] Starting subtest: fbcpsr-shrfb-scaledprimary
[547.644534] Subtest fbcpsr-shrfb-scaledprimary: SUCCESS (5.825s)
[547.768559] [108/133] (476s left) gem_render_copy (x-tiled)
[547.826656] Starting subtest: x-tiled
[547.831258] Starting dynamic subtest: smem
[547.868422] Dynamic subtest smem: SUCCESS (0.042s)
[547.871442] Subtest x-tiled: SUCCESS (0.043s)
[548.093657] [109/133] (476s left) gem_mmap_gtt (big-bo)
[548.148206] Subtest big-bo: SKIP (0.000s)
[548.205955] [110/133] (476s left) kms_hdr (bpc-switch-dpms)
[548.294551] Starting subtest: bpc-switch-dpms
[549.328479] Starting dynamic subtest: pipe-A-eDP-1
[553.846057] Dynamic subtest pipe-A-eDP-1: SUCCESS (4.518s)
[553.848441] Subtest bpc-switch-dpms: SUCCESS (5.551s)
[553.971037] [111/133] (470s left) kms_ccs (bad-rotation-90-4-tiled-mtl-mc-ccs)
[554.078657] Starting subtest: bad-rotation-90-4-tiled-mtl-mc-ccs
[554.081375] Starting dynamic subtest: pipe-A-eDP-1
[554.490953] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.415s)
[554.503224] Starting dynamic subtest: pipe-B-eDP-1
[554.524199] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.002s)
[554.533529] Starting dynamic subtest: pipe-C-eDP-1
[554.554800] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.003s)
[554.563889] Starting dynamic subtest: pipe-D-eDP-1
[554.584525] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.004s)
[554.586350] Subtest bad-rotation-90-4-tiled-mtl-mc-ccs: SUCCESS (0.429s)
[556.765438] [112/133] (467s left) gem_madvise (dontneed-before-pwrite)
[556.811111] Starting subtest: dontneed-before-pwrite
[556.834527] Subtest dontneed-before-pwrite: SKIP (0.019s)
[556.900798] [113/133] (467s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-indfb-msflip-blt)
[556.997154] Starting subtest: fbcpsr-2p-primscrn-indfb-msflip-blt
[557.002264] Subtest fbcpsr-2p-primscrn-indfb-msflip-blt: SKIP (0.000s)
[557.107235] [114/133] (467s left) gem_exec_schedule (preempt-other)
[557.175762] Starting subtest: preempt-other
[557.178382] Starting dynamic subtest: rcs0
[557.238090] Dynamic subtest rcs0: SUCCESS (0.073s)
[557.253035] Starting dynamic subtest: bcs0
[557.306995] Dynamic subtest bcs0: SUCCESS (0.068s)
[557.319370] Starting dynamic subtest: vcs0
[557.379382] Dynamic subtest vcs0: SUCCESS (0.071s)
[557.393658] Starting dynamic subtest: vcs1
[557.448752] Dynamic subtest vcs1: SUCCESS (0.069s)
[557.463194] Starting dynamic subtest: vecs0
[557.514669] Dynamic subtest vecs0: SUCCESS (0.066s)
[557.527710] Starting dynamic subtest: ccs0
[557.590362] Dynamic subtest ccs0: SUCCESS (0.074s)
[557.593492] Subtest preempt-other: SUCCESS (0.426s)
[558.693234] [115/133] (465s left) gem_exec_reloc (basic-write-gtt-noreloc)
[558.759709] Subtest basic-write-gtt-noreloc: SKIP (0.000s)
[558.833887] [116/133] (465s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-0-async-flip)
[558.941639] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-0-async-flip
[559.632640] Subtest x-tiled-max-hw-stride-32bpp-rotate-0-async-flip: SUCCESS (0.692s)
[559.807263] [117/133] (464s left) kms_psr2_su (frontbuffer-xrgb8888)
[559.879553] Subtest frontbuffer-XRGB8888: SKIP (0.000s)
[559.936329] [118/133] (464s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-indfb-draw-blt)
[560.042303] Starting subtest: psr-1p-offscreen-pri-indfb-draw-blt
[566.916656] Subtest psr-1p-offscreen-pri-indfb-draw-blt: SUCCESS (6.876s)
[567.044069] [119/133] (457s left) kms_draw_crc (fill-fb)
[567.148169] Starting subtest: fill-fb
[567.622258] Subtest fill-fb: SUCCESS (0.476s)
[567.718883] [120/133] (457s left) api_intel_allocator (two-level-inception)
[567.775906] Starting subtest: two-level-inception
[573.176283] Subtest two-level-inception: SUCCESS (5.398s)
[573.314791] [121/133] (451s left) gem_exec_params (cliprects-invalid)
[573.396206] Starting subtest: cliprects-invalid
[573.398442] Subtest cliprects-invalid: SUCCESS (0.000s)
[573.517741] [122/133] (451s left) kms_fbcon_fbt (psr-suspend)
[573.580216] Starting subtest: psr-suspend
[623.974364] Subtest psr-suspend: FAIL (22.772s)
[624.015621] [123/133] (401s left) kms_psr2_sf (pr-overlay-plane-update-continuous-sf)
[624.135367] Starting subtest: pr-overlay-plane-update-continuous-sf
[624.141526] Subtest pr-overlay-plane-update-continuous-sf: SKIP (0.000s)
[624.215834] [124/133] (400s left) gem_ctx_persistence (legacy-engines-hang)
[624.277207] Starting subtest: legacy-engines-hang
[624.279921] Starting dynamic subtest: render
[624.398323] Dynamic subtest render: SUCCESS (0.120s)
[624.415848] Starting dynamic subtest: bsd1
[624.499962] Dynamic subtest bsd1: SUCCESS (0.098s)
[624.515456] Starting dynamic subtest: bsd2
[624.599617] Dynamic subtest bsd2: SUCCESS (0.096s)
[624.612287] Starting dynamic subtest: blt
[624.649148] Dynamic subtest blt: SUCCESS (0.047s)
[624.661364] Starting dynamic subtest: vebox
[624.739590] Dynamic subtest vebox: SUCCESS (0.088s)
[624.742313] Subtest legacy-engines-hang: SUCCESS (0.463s)
[624.820601] [125/133] (400s left) kms_pm_rpm (fences-dpms)
[626.543450] Starting subtest: fences-dpms
[626.549424] Subtest fences-dpms: SKIP (0.000s)
[627.071604] [126/133] (398s left) kms_psr (psr2-cursor-render)
[627.176582] Starting subtest: psr2-cursor-render
[627.179202] Starting dynamic subtest: eDP-1
[628.869069] Dynamic subtest eDP-1: SUCCESS (1.691s)
[628.872028] Subtest psr2-cursor-render: SUCCESS (1.692s)
[629.673675] [127/133] (395s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-render)
[629.774960] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-render
[629.781439] Subtest psr-2p-scndscrn-spr-indfb-draw-render: SKIP (0.000s)
[629.867515] [128/133] (395s left) kms_properties (crtc-properties-legacy)
[629.956753] Starting subtest: crtc-properties-legacy
[629.959420] Starting dynamic subtest: pipe-A-eDP-1
[630.394076] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.439s)
[630.405717] Starting dynamic subtest: pipe-B-eDP-1
[631.545423] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.150s)
[631.566168] Starting dynamic subtest: pipe-C-eDP-1
[632.676244] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.127s)
[632.687948] Starting dynamic subtest: pipe-D-eDP-1
[633.801276] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.125s)
[633.804222] Subtest crtc-properties-legacy: SUCCESS (3.845s)
[634.611406] [129/133] (390s left) i915_query (test-query-geometry-subslices)
[634.672340] Starting subtest: test-query-geometry-subslices
[634.674879] Subtest test-query-geometry-subslices: SUCCESS (0.000s)
[634.753946] [130/133] (390s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-blt)
[634.847967] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-blt
[638.529749] Subtest fbc-1p-primscrn-cur-indfb-draw-blt: SUCCESS (3.684s)
[639.700223] [131/133] (385s left) kms_pipe_crc_basic (hang-read-crc)
[639.802905] Starting subtest: hang-read-crc
[639.805432] Starting dynamic subtest: pipe-A-eDP-1
[641.864862] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.061s)
[641.882006] Starting dynamic subtest: pipe-B-eDP-1
[644.643218] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.774s)
[644.654655] Starting dynamic subtest: pipe-C-eDP-1
[647.369165] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.724s)
[647.380350] Starting dynamic subtest: pipe-D-eDP-1
[650.027592] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.655s)
[650.030082] Subtest hang-read-crc: SUCCESS (10.219s)
[650.860678] [132/133] (374s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-shrfb-msflip-blt)
[650.957341] Starting subtest: fbcpsr-2p-scndscrn-shrfb-msflip-blt
[650.962976] Subtest fbcpsr-2p-scndscrn-shrfb-msflip-blt: SKIP (0.000s)
[651.050886] [133/133] (374s left) kms_ccs (ccs-on-another-bo-4-tiled-mtl-mc-ccs)
[651.140459] Starting subtest: ccs-on-another-bo-4-tiled-mtl-mc-ccs
[651.143127] Starting dynamic subtest: pipe-A-eDP-1
[651.165424] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.026s)
[651.175498] Starting dynamic subtest: pipe-B-eDP-1
[651.198172] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.025s)
[651.208235] Starting dynamic subtest: pipe-C-eDP-1
[651.230566] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.021s)
[651.243138] Starting dynamic subtest: pipe-D-eDP-1
[651.263652] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.021s)
[651.265661] Subtest ccs-on-another-bo-4-tiled-mtl-mc-ccs: SUCCESS (0.099s)
[653.448591] Closing watchdogs
results: parsing output: 0/ for test: kms_frontbuffer_tracking
results: parsing output: 1/ for test: kms_cursor_crc
results: parsing output: 2/ for test: gem_exec_reloc
results: parsing output: 3/ for test: core_setmaster
results: parsing output: 4/ for test: gem_userptr_blits
results: parsing output: 5/ for test: gem_exec_capture
results: parsing output: 6/ for test: kms_flip
results: parsing output: 7/ for test: kms_async_flips
results: parsing output: 8/ for test: gem_lmem_swapping
results: parsing output: 9/ for test: gem_exec_params
results: parsing output: 10/ for test: gem_render_copy
results: parsing output: 11/ for test: kms_big_fb
results: parsing output: 12/ for test: gem_render_copy
results: parsing output: 13/ for test: kms_draw_crc
results: parsing output: 14/ for test: kms_big_fb
results: parsing output: 15/ for test: kms_plane_cursor
results: parsing output: 16/ for test: gem_userptr_blits
results: parsing output: 17/ for test: gem_exec_balancer
results: parsing output: 18/ for test: kms_plane_scaling
results: parsing output: 19/ for test: syncobj_timeline
results: parsing output: 20/ for test: kms_chamelium_edid
results: parsing output: 21/ for test: kms_frontbuffer_tracking
results: parsing output: 22/ for test: kms_display_modes
results: parsing output: 23/ for test: kms_content_protection
results: parsing output: 24/ for test: kms_setmode
results: parsing output: 25/ for test: kms_psr
results: parsing output: 26/ for test: gem_tiled_partial_pwrite_pread
results: parsing output: 27/ for test: gem_softpin
results: parsing output: 28/ for test: kms_flip
results: parsing output: 29/ for test: sriov_basic
results: parsing output: 30/ for test: kms_cursor_legacy
results: parsing output: 31/ for test: kms_atomic_interruptible
results: parsing output: 32/ for test: gem_lmem_swapping
results: parsing output: 33/ for test: i915_pm_rpm
results: parsing output: 34/ for test: kms_pm_lpsp
results: parsing output: 35/ for test: gem_render_copy
results: parsing output: 36/ for test: gem_workarounds
results: parsing output: 37/ for test: syncobj_wait
results: parsing output: 38/ for test: i915_hangman
results: parsing output: 39/ for test: kms_color_pipeline
results: parsing output: 40/ for test: kms_pipe_b_c_ivb
results: parsing output: 41/ for test: kms_flip_scaled_crc
results: parsing output: 42/ for test: kms_invalid_mode
results: parsing output: 43/ for test: gem_ctx_persistence
results: parsing output: 44/ for test: perf_pmu
results: parsing output: 45/ for test: kms_vrr
results: parsing output: 46/ for test: kms_hdmi_inject
results: parsing output: 47/ for test: kms_flip
results: parsing output: 48/ for test: vgem_basic
results: parsing output: 49/ for test: gem_exec_params
results: parsing output: 50/ for test: syncobj_timeline
results: parsing output: 51/ for test: gem_exec_fence
results: parsing output: 52/ for test: vgem_basic
results: parsing output: 53/ for test: gen9_exec_parse
results: parsing output: 54/ for test: kms_vblank
results: parsing output: 55/ for test: kms_frontbuffer_tracking
results: parsing output: 56/ for test: kms_big_fb
results: parsing output: 57/ for test: kms_cursor_crc
results: parsing output: 58/ for test: kms_frontbuffer_tracking
results: parsing output: 59/ for test: kms_big_fb
results: parsing output: 60/ for test: kms_cursor_crc
results: parsing output: 61/ for test: kms_plane_scaling
results: parsing output: 62/ for test: kms_chamelium_hpd
results: parsing output: 63/ for test: syncobj_eventfd
results: parsing output: 64/ for test: kms_ccs
results: parsing output: 65/ for test: gem_exec_whisper
results: parsing output: 66/ for test: kms_frontbuffer_tracking
results: parsing output: 67/ for test: syncobj_timeline
results: parsing output: 68/ for test: kms_addfb_basic
results: parsing output: 69/ for test: kms_frontbuffer_tracking
results: parsing output: 70/ for test: gem_pread
results: parsing output: 71/ for test: kms_busy
results: parsing output: 72/ for test: kms_cursor_legacy
results: parsing output: 73/ for test: gem_exec_schedule
results: parsing output: 74/ for test: kms_force_connector_basic
results: parsing output: 75/ for test: kms_frontbuffer_tracking
results: parsing output: 76/ for test: kms_ccs
results: parsing output: 77/ for test: gem_caching
results: parsing output: 78/ for test: kms_psr_stress_test
results: parsing output: 79/ for test: gem_exec_params
results: parsing output: 80/ for test: kms_frontbuffer_tracking
results: parsing output: 81/ for test: syncobj_timeline
results: parsing output: 82/ for test: kms_plane
results: parsing output: 83/ for test: kms_psr2_sf
results: parsing output: 84/ for test: gem_partial_pwrite_pread
results: parsing output: 85/ for test: kms_vrr
results: parsing output: 86/ for test: gem_render_copy
results: parsing output: 87/ for test: gem_ctx_engines
results: parsing output: 88/ for test: kms_psr
results: parsing output: 89/ for test: api_intel_bb
results: parsing output: 90/ for test: kms_flip
results: parsing output: 91/ for test: gem_basic
results: parsing output: 92/ for test: kms_lease
results: parsing output: 93/ for test: syncobj_timeline
results: parsing output: 94/ for test: i915_drm_fdinfo
results: parsing output: 95/ for test: kms_ccs
results: parsing output: 96/ for test: gem_mmap_offset
results: parsing output: 97/ for test: kms_psr
results: parsing output: 98/ for test: gem_ctx_shared
results: parsing output: 99/ for test: kms_frontbuffer_tracking
results: parsing output: 100/ for test: sw_sync
results: parsing output: 101/ for test: kms_flip_scaled_crc
results: parsing output: 102/ for test: kms_big_fb
results: parsing output: 103/ for test: gem_workarounds
results: parsing output: 104/ for test: kms_flip
results: parsing output: 105/ for test: kms_atomic_transition
results: parsing output: 106/ for test: kms_frontbuffer_tracking
results: parsing output: 107/ for test: gem_render_copy
results: parsing output: 108/ for test: gem_mmap_gtt
results: parsing output: 109/ for test: kms_hdr
results: parsing output: 110/ for test: kms_ccs
results: parsing output: 111/ for test: gem_madvise
results: parsing output: 112/ for test: kms_frontbuffer_tracking
results: parsing output: 113/ for test: gem_exec_schedule
results: parsing output: 114/ for test: gem_exec_reloc
results: parsing output: 115/ for test: kms_big_fb
results: parsing output: 116/ for test: kms_psr2_su
results: parsing output: 117/ for test: kms_frontbuffer_tracking
results: parsing output: 118/ for test: kms_draw_crc
results: parsing output: 119/ for test: api_intel_allocator
results: parsing output: 120/ for test: gem_exec_params
results: parsing output: 121/ for test: kms_fbcon_fbt
results: parsing output: 122/ for test: kms_psr2_sf
results: parsing output: 123/ for test: gem_ctx_persistence
results: parsing output: 124/ for test: kms_pm_rpm
results: parsing output: 125/ for test: kms_psr
results: parsing output: 126/ for test: kms_frontbuffer_tracking
results: parsing output: 127/ for test: kms_properties
results: parsing output: 128/ for test: i915_query
results: parsing output: 129/ for test: kms_frontbuffer_tracking
results: parsing output: 130/ for test: kms_pipe_crc_basic
results: parsing output: 131/ for test: kms_frontbuffer_tracking
results: parsing output: 132/ for test: kms_ccs
Done.