[60.500919] Initializing watchdogs
[60.500968]   /dev/watchdog0
[60.515272] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7d55 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Arc Graphics]
[60.519800] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[60.522241] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[60.525645] [001/132] (960s left) gem_softpin (noreloc-interruptible)
[60.614831] Starting subtest: noreloc-interruptible
[66.026112] Subtest noreloc-interruptible: SUCCESS (5.412s)
[66.147916] [002/132] (954s left) kms_big_fb (linear-addfb)
[66.249198] Starting subtest: linear-addfb
[66.251109] Subtest linear-addfb: SUCCESS (0.000s)
[66.342286] [003/132] (954s left) kms_color (invalid-gamma-lut-sizes)
[66.441141] Starting subtest: invalid-gamma-lut-sizes
[66.443866] Starting dynamic subtest: pipe-A
[66.745708] Dynamic subtest pipe-A: SUCCESS (0.305s)
[66.755964] Starting dynamic subtest: pipe-B
[66.758893] Dynamic subtest pipe-B: SUCCESS (0.000s)
[66.766782] Starting dynamic subtest: pipe-C
[66.769193] Dynamic subtest pipe-C: SUCCESS (0.000s)
[66.776593] Starting dynamic subtest: pipe-D
[66.779014] Dynamic subtest pipe-D: SUCCESS (0.000s)
[66.781364] Subtest invalid-gamma-lut-sizes: SUCCESS (0.307s)
[67.628608] [004/132] (953s left) prime_vgem (basic-blt)
[67.890880] Starting subtest: basic-blt
[67.917400] Subtest basic-blt: SUCCESS (0.027s)
[68.167907] [FACT prime_vgem (basic-blt)] new: kernel.kmod_is_loaded.vgem: true
[68.170989] [005/132] (953s left) kms_ccs (crc-primary-basic-y-tiled-gen12-rc-ccs)
[68.257408] Starting subtest: crc-primary-basic-y-tiled-gen12-rc-ccs
[68.260072] Starting dynamic subtest: pipe-A-eDP-1
[68.282724] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[68.292723] Starting dynamic subtest: pipe-B-eDP-1
[68.313832] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[68.320684] Starting dynamic subtest: pipe-C-eDP-1
[68.341708] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[68.348133] Starting dynamic subtest: pipe-D-eDP-1
[68.369106] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[68.373037] Subtest crc-primary-basic-y-tiled-gen12-rc-ccs: SKIP (0.004s)
[70.589248] [006/132] (950s left) kms_psr2_sf (psr2-overlay-plane-update-continuous-sf)
[70.706888] Starting subtest: psr2-overlay-plane-update-continuous-sf
[70.709215] Starting dynamic subtest: pipe-A-eDP-1
[71.823454] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.121s)
[71.832991] Starting dynamic subtest: pipe-B-eDP-1
[73.541396] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.718s)
[73.543798] Subtest psr2-overlay-plane-update-continuous-sf: SUCCESS (2.841s)
[74.350065] [007/132] (946s left) kms_pipe_crc_basic (disable-crc-after-crtc)
[74.458395] Starting subtest: disable-crc-after-crtc
[74.460670] Starting dynamic subtest: pipe-A-eDP-1
[76.108143] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.648s)
[76.116759] Starting dynamic subtest: pipe-B-eDP-1
[78.374037] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.265s)
[78.381227] Starting dynamic subtest: pipe-C-eDP-1
[80.626519] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.250s)
[80.634568] Starting dynamic subtest: pipe-D-eDP-1
[82.898747] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.272s)
[82.901186] Subtest disable-crc-after-crtc: SUCCESS (8.439s)
[83.757459] [008/132] (937s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-shrfb-msflip-blt)
[83.869632] Starting subtest: fbcpsr-1p-primscrn-shrfb-msflip-blt
[91.184948] Subtest fbcpsr-1p-primscrn-shrfb-msflip-blt: SUCCESS (7.317s)
[91.344216] [009/132] (930s left) kms_cursor_legacy (cursorb-vs-flipa-atomic-transitions-varying-size)
[91.468278] Starting subtest: cursorB-vs-flipA-atomic-transitions-varying-size
[91.472777] Subtest cursorB-vs-flipA-atomic-transitions-varying-size: SKIP (0.001s)
[91.613026] [010/132] (929s left) kms_frontbuffer_tracking (fbc-1p-rte)
[91.714871] Starting subtest: fbc-1p-rte
[97.139685] Subtest fbc-1p-rte: SUCCESS (5.429s)
[98.271710] [011/132] (923s left) perf (missing-sample-flags)
[98.413743] Starting subtest: missing-sample-flags
[98.416061] Subtest missing-sample-flags: SUCCESS (0.000s)
[98.451434] [012/132] (923s left) kms_legacy_colorkey (basic)
[98.539636] Starting subtest: basic
[98.541502] Starting dynamic subtest: pipe-A
[98.582712] Dynamic subtest pipe-A: SUCCESS (0.045s)
[98.591572] Starting dynamic subtest: pipe-B
[98.593769] Dynamic subtest pipe-B: SUCCESS (0.001s)
[98.600740] Starting dynamic subtest: pipe-C
[98.602592] Dynamic subtest pipe-C: SUCCESS (0.001s)
[98.609526] Starting dynamic subtest: pipe-D
[98.611635] Dynamic subtest pipe-D: SUCCESS (0.001s)
[98.613708] Subtest basic: SUCCESS (0.050s)
[98.648089] [013/132] (922s left) syncobj_timeline (single-wait-all-signaled)
[98.699911] Starting subtest: single-wait-all-signaled
[98.702241] Subtest single-wait-all-signaled: SUCCESS (0.000s)
[98.790628] [014/132] (922s left) core_hotunplug (unbind-rebind)
[98.880986] Starting subtest: unbind-rebind
[104.746531] Subtest unbind-rebind: SUCCESS (5.866s)
[104.790222] [015/132] (916s left) syncobj_eventfd (timeline-wait)
[105.916674] Starting subtest: timeline-wait
[105.924908] Subtest timeline-wait: SUCCESS (0.011s)
[106.056670] [016/132] (915s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-0-async-flip)
[106.163526] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-0-async-flip
[106.167924] Subtest yf-tiled-max-hw-stride-32bpp-rotate-0-async-flip: SKIP (0.000s)
[106.277715] [017/132] (915s left) kms_pm_lpsp (screens-disabled)
[107.377206] Starting subtest: screens-disabled
[107.381267] Subtest screens-disabled: SKIP (0.000s)
[107.462906] [018/132] (914s left) gem_mmap_wc (write-read)
[107.513191] Subtest write-read: SKIP (0.000s)
[107.567482] [019/132] (914s left) kms_flip (flip-vs-wf_vblank-interruptible)
[107.653610] Starting subtest: flip-vs-wf_vblank-interruptible
[107.655909] Starting dynamic subtest: A-eDP1
[109.587290] Dynamic subtest A-eDP1: SUCCESS (1.932s)
[109.596105] Starting dynamic subtest: B-eDP1
[111.514398] Dynamic subtest B-eDP1: SUCCESS (1.926s)
[111.525056] Starting dynamic subtest: C-eDP1
[113.429693] Dynamic subtest C-eDP1: SUCCESS (1.914s)
[113.440734] Starting dynamic subtest: D-eDP1
[115.351176] Dynamic subtest D-eDP1: SUCCESS (1.920s)
[115.357299] Subtest flip-vs-wf_vblank-interruptible: SUCCESS (7.704s)
[116.575870] [020/132] (905s left) gem_exec_parallel (fds)
[116.634323] Starting subtest: fds
[116.636604] Starting dynamic subtest: rcs0
[119.214060] Dynamic subtest rcs0: SUCCESS (2.578s)
[119.225174] Starting dynamic subtest: bcs0
[122.449723] Dynamic subtest bcs0: SUCCESS (3.234s)
[122.460662] Starting dynamic subtest: vcs0
[126.141329] Dynamic subtest vcs0: SUCCESS (3.691s)
[126.150552] Starting dynamic subtest: vcs1
[130.210815] Dynamic subtest vcs1: SUCCESS (4.068s)
[130.221409] Starting dynamic subtest: vecs0
[134.176492] Dynamic subtest vecs0: SUCCESS (3.964s)
[134.184876] Starting dynamic subtest: ccs0
[138.048694] Dynamic subtest ccs0: SUCCESS (3.870s)
[138.051963] Subtest fds: SUCCESS (21.413s)
[138.257301] [021/132] (883s left) syncobj_wait (single-wait-for-submit-unsubmitted)
[138.318975] Starting subtest: single-wait-for-submit-unsubmitted
[138.426115] Subtest single-wait-for-submit-unsubmitted: SUCCESS (0.105s)
[138.504171] [022/132] (883s left) gem_workarounds (suspend-resume-context)
[138.586681] Starting subtest: suspend-resume-context
[154.699710] Subtest suspend-resume-context: SUCCESS (2.039s)
[154.834433] [023/132] (867s left) kms_sequence (get-forked)
[154.944188] Starting subtest: get-forked
[154.946423] Starting dynamic subtest: pipe-A-eDP-1
[156.863329] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.916s)
[156.872831] Starting dynamic subtest: pipe-B-eDP-1
[159.425980] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.557s)
[159.437105] Starting dynamic subtest: pipe-C-eDP-1
[161.951642] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.525s)
[161.961999] Starting dynamic subtest: pipe-D-eDP-1
[164.473445] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.520s)
[164.475741] Subtest get-forked: SUCCESS (9.522s)
[165.313144] [024/132] (856s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-mmap-wc)
[165.408887] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-mmap-wc
[168.993643] Subtest fbc-1p-primscrn-cur-indfb-draw-mmap-wc: SUCCESS (3.587s)
[170.129274] [025/132] (851s left) perf_pmu (faulting-read)
[170.168207] Starting subtest: faulting-read
[170.170415] Starting dynamic subtest: wb
[170.172662] Dynamic subtest wb: SUCCESS (0.001s)
[170.182146] Starting dynamic subtest: wc
[170.184010] Dynamic subtest wc: SUCCESS (0.001s)
[170.192556] Starting dynamic subtest: uc
[170.194416] Dynamic subtest uc: SUCCESS (0.001s)
[170.196278] Subtest faulting-read: SUCCESS (0.007s)
[170.279687] [026/132] (851s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-16bpp-ytile-upscaling)
[170.375207] Starting subtest: flip-64bpp-ytile-to-16bpp-ytile-upscaling
[170.379418] Subtest flip-64bpp-ytile-to-16bpp-ytile-upscaling: SKIP (0.000s)
[170.478880] [027/132] (851s left) syncobj_basic (test-valid-cycle)
[170.528006] Starting subtest: test-valid-cycle
[170.530099] Subtest test-valid-cycle: SUCCESS (0.000s)
[170.618648] [028/132] (851s left) kms_ccs (crc-primary-rotation-180-4-tiled-dg2-rc-ccs-cc)
[170.724532] Starting subtest: crc-primary-rotation-180-4-tiled-dg2-rc-ccs-cc
[170.726717] Starting dynamic subtest: pipe-A-eDP-1
[170.749273] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[170.760120] Starting dynamic subtest: pipe-B-eDP-1
[170.780390] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[170.788991] Starting dynamic subtest: pipe-C-eDP-1
[170.809647] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[170.818415] Starting dynamic subtest: pipe-D-eDP-1
[170.839613] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[170.843508] Subtest crc-primary-rotation-180-4-tiled-dg2-rc-ccs-cc: SKIP (0.008s)
[172.977723] [029/132] (849s left) i915_pciid
[173.168695] [030/132] (849s left) perf_pmu (all-busy-idle-check-all)
[173.212244] Starting subtest: all-busy-idle-check-all
[173.909954] Subtest all-busy-idle-check-all: FAIL (0.631s)
[175.063875] [031/132] (847s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-mmap-wc)
[175.164914] Starting subtest: fbcpsr-rgb101010-draw-mmap-wc
[181.895938] Subtest fbcpsr-rgb101010-draw-mmap-wc: SUCCESS (6.733s)
[181.995899] [032/132] (840s left) perf (enable-disable)
[182.138411] Starting subtest: enable-disable
[182.140782] Starting dynamic subtest: 0-rcs0
[184.394994] Dynamic subtest 0-rcs0: SUCCESS (2.254s)
[184.405424] Starting dynamic subtest: 1-vcs0
[188.844688] Dynamic subtest 1-vcs0: SUCCESS (4.449s)
[188.847180] Subtest enable-disable: SUCCESS (6.705s)
[188.893628] [033/132] (833s left) gem_lmem_swapping (parallel-random-engines)
[188.949102] Subtest parallel-random-engines: SKIP (0.000s)
[189.000006] [034/132] (833s left) gem_ccs (block-multicopy-inplace)
[189.058923] Starting subtest: block-multicopy-inplace
[189.063320] Subtest block-multicopy-inplace: SKIP (0.000s)
[189.160230] [035/132] (833s left) kms_draw_crc (draw-method-render)
[189.249355] Starting subtest: draw-method-render
[189.251219] Starting dynamic subtest: xrgb8888-untiled
[189.490367] Dynamic subtest xrgb8888-untiled: SUCCESS (0.243s)
[189.499932] Starting dynamic subtest: rgb565-untiled
[189.701244] Dynamic subtest rgb565-untiled: SUCCESS (0.210s)
[189.710894] Starting dynamic subtest: xrgb2101010-untiled
[189.912437] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.211s)
[189.921292] Starting dynamic subtest: xbgr16161616f-untiled
[190.156629] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.244s)
[190.168394] Starting dynamic subtest: xrgb8888-xtiled
[190.278905] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.120s)
[190.290394] Starting dynamic subtest: rgb565-xtiled
[190.412307] Dynamic subtest rgb565-xtiled: SUCCESS (0.133s)
[190.424647] Starting dynamic subtest: xrgb2101010-xtiled
[190.534833] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.120s)
[190.546750] Starting dynamic subtest: xbgr16161616f-xtiled
[190.656747] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (0.121s)
[190.668801] Starting dynamic subtest: xrgb8888-4tiled
[190.790211] Dynamic subtest xrgb8888-4tiled: SUCCESS (0.131s)
[190.801972] Starting dynamic subtest: rgb565-4tiled
[190.901265] Dynamic subtest rgb565-4tiled: SUCCESS (0.110s)
[190.910987] Starting dynamic subtest: xrgb2101010-4tiled
[191.012350] Dynamic subtest xrgb2101010-4tiled: SUCCESS (0.110s)
[191.024031] Starting dynamic subtest: xbgr16161616f-4tiled
[191.145905] Dynamic subtest xbgr16161616f-4tiled: SUCCESS (0.131s)
[191.147814] Subtest draw-method-render: SUCCESS (1.900s)
[191.225709] [036/132] (831s left) kms_rotation_crc (primary-yf-tiled-reflect-x-90)
[191.315784] Starting subtest: primary-yf-tiled-reflect-x-90
[191.319517] Subtest primary-yf-tiled-reflect-x-90: SKIP (0.001s)
[191.389296] [037/132] (831s left) gem_mmap_gtt (basic-read-write)
[191.454248] Subtest basic-read-write: SKIP (0.000s)
[191.522558] [038/132] (831s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-blt)
[191.616175] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-blt
[198.452088] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-blt: SUCCESS (6.835s)
[198.588573] [039/132] (824s left) kms_psr (pr-cursor-plane-move)
[198.697453] Starting subtest: pr-cursor-plane-move
[198.702049] Subtest pr-cursor-plane-move: SKIP (0.000s)
[198.773756] [040/132] (823s left) core_getstats (basic)
[198.833120] Starting subtest: basic
[198.835360] Subtest basic: SUCCESS (0.000s)
[198.932378] [041/132] (823s left) kms_hdr (bpc-switch-suspend)
[199.023240] Starting subtest: bpc-switch-suspend
[200.105427] Starting dynamic subtest: pipe-A-eDP-1
[219.851296] Dynamic subtest pipe-A-eDP-1: SUCCESS (4.504s)
[219.853616] Subtest bpc-switch-suspend: SUCCESS (5.589s)
[219.967243] [042/132] (802s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-mmap-wc)
[220.069733] Starting subtest: psr-1p-primscrn-cur-indfb-draw-mmap-wc
[226.525660] Subtest psr-1p-primscrn-cur-indfb-draw-mmap-wc: SUCCESS (6.455s)
[226.652768] [043/132] (796s left) gem_ctx_exec (basic)
[226.711820] Starting subtest: basic
[226.717555] Subtest basic: SUCCESS (0.006s)
[226.844456] [044/132] (795s left) gem_exec_schedule (preempt)
[226.913027] Starting subtest: preempt
[226.914969] Starting dynamic subtest: rcs0
[226.929463] Dynamic subtest rcs0: SUCCESS (0.024s)
[226.941177] Starting dynamic subtest: bcs0
[226.956357] Dynamic subtest bcs0: SUCCESS (0.026s)
[226.966126] Starting dynamic subtest: vcs0
[226.976303] Dynamic subtest vcs0: SUCCESS (0.019s)
[226.985809] Starting dynamic subtest: vcs1
[226.997383] Dynamic subtest vcs1: SUCCESS (0.020s)
[227.006735] Starting dynamic subtest: vecs0
[227.016163] Dynamic subtest vecs0: SUCCESS (0.018s)
[227.026365] Starting dynamic subtest: ccs0
[227.036409] Dynamic subtest ccs0: SUCCESS (0.019s)
[227.038617] Subtest preempt: SUCCESS (0.131s)
[228.283678] [045/132] (794s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-render)
[228.393772] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-render
[228.398171] Subtest psr-2p-scndscrn-pri-indfb-draw-render: SKIP (0.000s)
[228.481586] [046/132] (794s left) kms_cursor_crc (cursor-random-512x512)
[228.736003] Starting subtest: cursor-random-512x512
[228.741176] Subtest cursor-random-512x512: SKIP (0.001s)
[228.902545] [047/132] (794s left) kms_addfb_basic (invalid-smem-bo-on-discrete)
[228.964966] Starting subtest: invalid-smem-bo-on-discrete
[228.969678] Subtest invalid-smem-bo-on-discrete: SKIP (0.000s)
[229.095652] [048/132] (793s left) kms_big_fb (y-tiled-32bpp-rotate-90)
[229.214885] Starting subtest: y-tiled-32bpp-rotate-90
[229.219155] Subtest y-tiled-32bpp-rotate-90: SKIP (0.000s)
[229.299735] [049/132] (793s left) kms_big_fb (yf-tiled-16bpp-rotate-0)
[229.407319] Starting subtest: yf-tiled-16bpp-rotate-0
[229.410835] Subtest yf-tiled-16bpp-rotate-0: SKIP (0.000s)
[229.499589] [050/132] (793s left) gem_exec_reloc (basic-cpu-gtt-noreloc)
[229.562209] Subtest basic-cpu-gtt-noreloc: SKIP (0.000s)
[229.641263] [051/132] (793s left) kms_big_fb (4-tiled-64bpp-rotate-180)
[229.740255] Starting subtest: 4-tiled-64bpp-rotate-180
[231.342694] Subtest 4-tiled-64bpp-rotate-180: SUCCESS (1.602s)
[231.519842] [052/132] (791s left) kms_big_fb (x-tiled-64bpp-rotate-0)
[231.621221] Starting subtest: x-tiled-64bpp-rotate-0
[233.091596] Subtest x-tiled-64bpp-rotate-0: SUCCESS (1.468s)
[233.268664] [053/132] (789s left) kms_psr2_sf (fbc-psr2-overlay-plane-move-continuous-exceed-fully-sf)
[233.376522] Starting subtest: fbc-psr2-overlay-plane-move-continuous-exceed-fully-sf
[233.378779] Starting dynamic subtest: pipe-A-eDP-1
[233.460521] Dynamic subtest pipe-A-eDP-1: SKIP (0.088s)
[233.470944] Starting dynamic subtest: pipe-B-eDP-1
[234.617962] Dynamic subtest pipe-B-eDP-1: SKIP (1.157s)
[234.622369] Subtest fbc-psr2-overlay-plane-move-continuous-exceed-fully-sf: SKIP (1.248s)
[235.800291] [054/132] (787s left) kms_dirtyfb (psr-dirtyfb-ioctl)
[235.886346] Starting subtest: psr-dirtyfb-ioctl
[235.888263] Starting dynamic subtest: A-eDP-1
[239.729137] Dynamic subtest A-eDP-1: SUCCESS (3.840s)
[239.731067] Subtest psr-dirtyfb-ioctl: SUCCESS (3.841s)
[240.530680] [055/132] (782s left) kms_chamelium_edid (dp-edid-stress-resolution-4k)
[240.925400] Subtest dp-edid-stress-resolution-4k: SKIP (0.000s)
[241.756431] [056/132] (781s left) kms_psr (fbc-psr-primary-mmap-gtt)
[241.846409] Starting subtest: fbc-psr-primary-mmap-gtt
[241.848910] Starting dynamic subtest: eDP-1
[241.852990] Dynamic subtest eDP-1: SKIP (0.000s)
[241.856921] Subtest fbc-psr-primary-mmap-gtt: SKIP (0.001s)
[241.922656] [057/132] (781s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-render)
[242.018004] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-render
[242.021927] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-render: SKIP (0.000s)
[242.112772] [058/132] (781s left) gem_exec_schedule (submit-late-slice)
[242.175393] Starting subtest: submit-late-slice
[242.177498] Starting dynamic subtest: rcs0
[242.207400] Dynamic subtest rcs0: SUCCESS (0.036s)
[242.220445] Starting dynamic subtest: bcs0
[242.237680] Dynamic subtest bcs0: SUCCESS (0.030s)
[242.246846] Starting dynamic subtest: vcs0
[242.270567] Dynamic subtest vcs0: SUCCESS (0.032s)
[242.279979] Starting dynamic subtest: vcs1
[242.311696] Dynamic subtest vcs1: SUCCESS (0.040s)
[242.322917] Starting dynamic subtest: vecs0
[242.340531] Dynamic subtest vecs0: SUCCESS (0.028s)
[242.356400] Starting dynamic subtest: ccs0
[242.381349] Dynamic subtest ccs0: SUCCESS (0.040s)
[242.383560] Subtest submit-late-slice: SUCCESS (0.211s)
[244.342728] [059/132] (779s left) gem_render_copy (yf-tiled-ccs-to-yf-tiled-ccs)
[244.411293] Starting subtest: yf-tiled-ccs-to-yf-tiled-ccs
[244.415429] Subtest yf-tiled-ccs-to-yf-tiled-ccs: SKIP (0.000s)
[244.589969] [060/132] (778s left) gem_spin_batch (spin-each)
[244.654805] Starting subtest: spin-each
[248.023163] Subtest spin-each: SUCCESS (3.369s)
[248.309781] [061/132] (775s left) gem_mmap_offset (perf)
[248.362956] Starting subtest: perf
[248.364806] Starting dynamic subtest: smem0
[248.714708] Dynamic subtest smem0: SUCCESS (0.351s)
[248.717180] Subtest perf: SUCCESS (0.352s)
[248.839907] [062/132] (774s left) gem_exec_schedule (wide)
[249.023273] Starting subtest: wide
[249.025558] Starting dynamic subtest: rcs0
[259.973652] Dynamic subtest rcs0: SUCCESS (10.950s)
[259.987889] Starting dynamic subtest: vcs0
[273.411268] Dynamic subtest vcs0: SUCCESS (13.437s)
[273.423925] Starting dynamic subtest: vcs1
[285.477098] Dynamic subtest vcs1: SUCCESS (12.062s)
[285.488885] Starting dynamic subtest: vecs0
[296.778992] Dynamic subtest vecs0: SUCCESS (11.300s)
[296.789132] Starting dynamic subtest: ccs0
[310.676734] Dynamic subtest ccs0: SUCCESS (13.894s)
[310.679395] Subtest wide: SUCCESS (61.648s)
[312.692713] [063/132] (710s left) gem_exec_fence (syncobj-invalid-wait)
[313.180284] Starting subtest: syncobj-invalid-wait
[313.182741] Subtest syncobj-invalid-wait: SUCCESS (0.001s)
[314.257689] [064/132] (709s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling)
[314.377548] Starting subtest: flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling
[314.382148] Subtest flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling: SKIP (0.000s)
[314.451625] [065/132] (709s left) kms_cursor_legacy (cursor-vs-flip-toggle)
[314.567715] Starting subtest: cursor-vs-flip-toggle
[345.830112] Subtest cursor-vs-flip-toggle: SUCCESS (31.262s)
[346.708461] [066/132] (677s left) kms_cursor_crc (cursor-tearing-position-change)
[346.840968] Starting subtest: cursor-tearing-position-change
[346.843259] Starting dynamic subtest: pipe-A-eDP-1
[347.409603] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.566s)
[347.420435] Starting dynamic subtest: pipe-D-eDP-1
[348.655268] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.245s)
[348.657504] Subtest cursor-tearing-position-change: SUCCESS (1.814s)
[349.502377] [067/132] (674s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-mmap-gtt)
[349.611560] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-mmap-gtt
[349.615906] Subtest fbc-2p-scndscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[349.714051] [068/132] (674s left) gem_ctx_sseu (engines)
[349.775377] Subtest engines: SKIP (0.000s)
[349.846298] [069/132] (674s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-move)
[349.931137] Starting subtest: fbc-2p-primscrn-cur-indfb-move
[349.935576] Subtest fbc-2p-primscrn-cur-indfb-move: SKIP (0.000s)
[350.034760] [070/132] (673s left) kms_flip (wf_vblank-ts-check-interruptible)
[350.126642] Starting subtest: wf_vblank-ts-check-interruptible
[350.129002] Starting dynamic subtest: A-eDP1
[359.020286] Dynamic subtest A-eDP1: SUCCESS (8.892s)
[359.033143] Starting dynamic subtest: B-eDP1
[367.951157] Dynamic subtest B-eDP1: SUCCESS (8.929s)
[367.963054] Starting dynamic subtest: C-eDP1
[376.877285] Dynamic subtest C-eDP1: SUCCESS (8.924s)
[376.891287] Starting dynamic subtest: D-eDP1
[385.813747] Dynamic subtest D-eDP1: SUCCESS (8.935s)
[385.816326] Subtest wf_vblank-ts-check-interruptible: SUCCESS (35.687s)
[387.036142] [071/132] (636s left) api_intel_allocator (simple-allocator)
[387.096617] Starting subtest: simple-allocator
[387.098998] Starting dynamic subtest: basic
[387.101250] Dynamic subtest basic: SUCCESS (0.003s)
[387.115367] Starting dynamic subtest: parallel-one
[387.293550] Dynamic subtest parallel-one: SUCCESS (0.194s)
[387.305256] Starting dynamic subtest: print
[387.307793] Dynamic subtest print: SUCCESS (0.000s)
[387.317273] Starting dynamic subtest: reuse
[387.319250] Dynamic subtest reuse: SUCCESS (0.000s)
[387.328656] Starting dynamic subtest: reserve
[387.330629] Dynamic subtest reserve: SUCCESS (0.000s)
[387.340107] Starting dynamic subtest: fork-reopen-allocator
[387.342157] Dynamic subtest fork-reopen-allocator: SUCCESS (0.013s)
[387.344180] Subtest simple-allocator: SUCCESS (0.216s)
[387.454070] [072/132] (636s left) kms_flip (2x-flip-vs-modeset-vs-hang)
[387.546689] Starting subtest: 2x-flip-vs-modeset-vs-hang
[387.557473] Subtest 2x-flip-vs-modeset-vs-hang: SKIP (0.010s)
[387.641220] [073/132] (636s left) gem_ctx_param (set-priority-range)
[387.690986] Starting subtest: set-priority-range
[387.704948] Subtest set-priority-range: SUCCESS (0.014s)
[387.806002] [074/132] (636s left) gem_ctx_persistence (engines-hostile-preempt)
[387.862345] Starting subtest: engines-hostile-preempt
[387.864662] Starting dynamic subtest: rcs0
[387.946157] Dynamic subtest rcs0: SUCCESS (0.083s)
[387.962762] Starting dynamic subtest: bcs0
[387.998053] Dynamic subtest bcs0: SUCCESS (0.049s)
[388.011604] Starting dynamic subtest: vcs0
[389.183286] Dynamic subtest vcs0: SUCCESS (1.181s)
[389.194644] Starting dynamic subtest: vcs1
[391.231808] Dynamic subtest vcs1: SUCCESS (2.046s)
[391.242556] Starting dynamic subtest: vecs0
[393.235522] Dynamic subtest vecs0: SUCCESS (2.001s)
[393.246132] Starting dynamic subtest: ccs0
[393.266864] Dynamic subtest ccs0: SUCCESS (0.030s)
[393.269503] Subtest engines-hostile-preempt: SUCCESS (5.404s)
[393.399328] [075/132] (630s left) kms_atomic_transition (modeset-transition-fencing)
[393.503032] Starting subtest: modeset-transition-fencing
[393.504933] Starting dynamic subtest: 1x-outputs
[404.262559] Dynamic subtest 1x-outputs: SUCCESS (10.759s)
[404.264991] Subtest modeset-transition-fencing: SUCCESS (10.761s)
[405.124861] [076/132] (619s left) kms_hdr (static-swap)
[405.219061] Starting subtest: static-swap
[405.225083] Subtest static-swap: SKIP (0.000s)
[405.294087] [077/132] (618s left) kms_ccs (random-ccs-data-4-tiled-bmg-ccs)
[405.381515] Starting subtest: random-ccs-data-4-tiled-bmg-ccs
[405.386019] Subtest random-ccs-data-4-tiled-bmg-ccs: SKIP (0.000s)
[406.461516] [078/132] (617s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-mmap-cpu)
[406.563166] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-mmap-cpu
[406.567319] Subtest fbc-2p-scndscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[406.651102] [079/132] (617s left) gem_exec_params (larger-than-life-batch)
[406.705056] Starting subtest: larger-than-life-batch
[409.033515] Subtest larger-than-life-batch: SUCCESS (2.327s)
[410.256810] [080/132] (614s left) gem_pxp (create-protected-buffer)
[410.438911] Starting subtest: create-protected-buffer
[410.441284] Subtest create-protected-buffer: SUCCESS (0.000s)
[410.548081] [081/132] (613s left) sysfs_heartbeat_interval (idempotent)
[410.603638] Starting subtest: idempotent
[410.606085] Starting dynamic subtest: vecs0
[410.608669] Dynamic subtest vecs0: SUCCESS (0.001s)
[410.621376] Starting dynamic subtest: ccs0
[410.623454] Dynamic subtest ccs0: SUCCESS (0.002s)
[410.632792] Starting dynamic subtest: vcs0
[410.634893] Dynamic subtest vcs0: SUCCESS (0.000s)
[410.644301] Starting dynamic subtest: bcs0
[410.646099] Dynamic subtest bcs0: SUCCESS (0.002s)
[410.655433] Starting dynamic subtest: rcs0
[410.657560] Dynamic subtest rcs0: SUCCESS (0.002s)
[410.666869] Starting dynamic subtest: vcs1
[410.668740] Dynamic subtest vcs1: SUCCESS (0.001s)
[410.670579] Subtest idempotent: SUCCESS (0.012s)
[410.711582] [082/132] (613s left) kms_plane_scaling (plane-downscale-factor-0-5-with-rotation)
[410.820830] Starting subtest: plane-downscale-factor-0-5-with-rotation
[410.822916] Starting dynamic subtest: pipe-A
[410.840573] Dynamic subtest pipe-A: SKIP (0.017s)
[410.853128] Starting dynamic subtest: pipe-B
[410.871525] Dynamic subtest pipe-B: SKIP (0.028s)
[410.883405] Starting dynamic subtest: pipe-C
[410.898411] Dynamic subtest pipe-C: SKIP (0.028s)
[410.908256] Starting dynamic subtest: pipe-D
[410.930006] Dynamic subtest pipe-D: SKIP (0.031s)
[410.933643] Subtest plane-downscale-factor-0-5-with-rotation: SKIP (0.106s)
[411.051520] [083/132] (613s left) syncobj_timeline (etime-multi-wait-all-for-submit-unsubmitted-submitted-signa
[411.124880] Starting subtest: etime-multi-wait-all-for-submit-unsubmitted-submitted-signaled
[411.229280] Subtest etime-multi-wait-all-for-submit-unsubmitted-submitted-signaled: SUCCESS (0.105s)
[411.303808] [084/132] (613s left) gem_softpin (32b-excludes-last-page)
[411.349625] Starting subtest: 32b-excludes-last-page
[411.354557] Subtest 32b-excludes-last-page: SUCCESS (0.003s)
[411.468093] [085/132] (613s left) kms_plane_cursor (viewport)
[411.550311] Starting subtest: viewport
[411.554512] Starting dynamic subtest: pipe-A-eDP-1-size-64
[414.004599] Dynamic subtest pipe-A-eDP-1-size-64: SUCCESS (2.453s)
[414.062013] Starting dynamic subtest: pipe-A-eDP-1-size-128
[416.561365] Dynamic subtest pipe-A-eDP-1-size-128: SUCCESS (2.505s)
[416.622981] Starting dynamic subtest: pipe-A-eDP-1-size-256
[419.116822] Dynamic subtest pipe-A-eDP-1-size-256: SUCCESS (2.504s)
[419.472428] Starting dynamic subtest: pipe-B-eDP-1-size-64
[422.617644] Dynamic subtest pipe-B-eDP-1-size-64: SUCCESS (3.159s)
[422.680751] Starting dynamic subtest: pipe-B-eDP-1-size-128
[425.064174] Dynamic subtest pipe-B-eDP-1-size-128: SUCCESS (2.393s)
[425.126358] Starting dynamic subtest: pipe-B-eDP-1-size-256
[427.544236] Dynamic subtest pipe-B-eDP-1-size-256: SUCCESS (2.429s)
[427.906130] Starting dynamic subtest: pipe-C-eDP-1-size-64
[430.695317] Dynamic subtest pipe-C-eDP-1-size-64: SUCCESS (2.799s)
[430.733476] Starting dynamic subtest: pipe-C-eDP-1-size-128
[432.795913] Dynamic subtest pipe-C-eDP-1-size-128: SUCCESS (2.069s)
[432.833649] Starting dynamic subtest: pipe-C-eDP-1-size-256
[434.851878] Dynamic subtest pipe-C-eDP-1-size-256: SUCCESS (2.025s)
[435.186519] Starting dynamic subtest: pipe-D-eDP-1-size-64
[438.026706] Dynamic subtest pipe-D-eDP-1-size-64: SUCCESS (2.851s)
[438.065925] Starting dynamic subtest: pipe-D-eDP-1-size-128
[440.116208] Dynamic subtest pipe-D-eDP-1-size-128: SUCCESS (2.059s)
[440.154933] Starting dynamic subtest: pipe-D-eDP-1-size-256
[442.316346] Dynamic subtest pipe-D-eDP-1-size-256: SUCCESS (2.169s)
[442.633049] Subtest viewport: SUCCESS (31.079s)
[443.490038] [086/132] (581s left) kms_cursor_legacy (flip-vs-cursor-busy-crc-legacy)
[443.610221] Starting subtest: flip-vs-cursor-busy-crc-legacy
[444.440633] Subtest flip-vs-cursor-busy-crc-legacy: SUCCESS (0.828s)
[445.304172] [087/132] (579s left) i915_pm_rpm (gem-evict-pwrite)
[447.334239] Starting subtest: gem-evict-pwrite
[447.339549] Subtest gem-evict-pwrite: SKIP (0.000s)
[447.735282] [088/132] (576s left) kms_vblank (crtc-id)
[447.840672] Starting subtest: crtc-id
[447.842972] Starting dynamic subtest: pipe-A-eDP-1
[448.290378] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.450s)
[448.305418] Starting dynamic subtest: pipe-D-eDP-1
[449.442212] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.147s)
[449.444442] Subtest crtc-id: SUCCESS (1.603s)
[450.290457] [089/132] (574s left) gem_eio (wait-wedge-immediate)
[450.529873] Starting subtest: wait-wedge-immediate
[452.256554] Subtest wait-wedge-immediate: SUCCESS (1.726s)
[452.370452] [090/132] (572s left) kms_ccs (bad-aux-stride-y-tiled-gen12-rc-ccs)
[452.458249] Starting subtest: bad-aux-stride-y-tiled-gen12-rc-ccs
[452.460451] Starting dynamic subtest: pipe-A-eDP-1
[452.482723] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[452.495510] Starting dynamic subtest: pipe-B-eDP-1
[452.516087] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[452.525646] Starting dynamic subtest: pipe-C-eDP-1
[452.547204] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[452.556787] Starting dynamic subtest: pipe-D-eDP-1
[452.578840] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[452.583288] Subtest bad-aux-stride-y-tiled-gen12-rc-ccs: SKIP (0.004s)
[454.747094] [091/132] (570s left) kms_flip (2x-flip-vs-rmfb)
[454.859900] Starting subtest: 2x-flip-vs-rmfb
[454.868259] Subtest 2x-flip-vs-rmfb: SKIP (0.010s)
[454.946510] [092/132] (569s left) kms_plane (pixel-format-4-tiled-mtl-rc-ccs-modifier-source-clamping)
[455.039735] Starting subtest: pixel-format-4-tiled-mtl-rc-ccs-modifier-source-clamping
[455.065862] Starting dynamic subtest: pipe-A-plane-0
[455.356793] Dynamic subtest pipe-A-plane-0: SUCCESS (0.289s)
[455.367360] Starting dynamic subtest: pipe-A-plane-3
[455.587584] Dynamic subtest pipe-A-plane-3: SUCCESS (0.233s)
[456.726923] Starting dynamic subtest: pipe-B-plane-0
[457.029603] Dynamic subtest pipe-B-plane-0: SUCCESS (0.311s)
[457.040974] Starting dynamic subtest: pipe-B-plane-3
[457.262091] Dynamic subtest pipe-B-plane-3: SUCCESS (0.231s)
[457.591350] Subtest pixel-format-4-tiled-mtl-rc-ccs-modifier-source-clamping: SUCCESS (2.551s)
[458.402476] [093/132] (566s left) i915_suspend (sysfs-reader)
[458.467840] Starting subtest: sysfs-reader
[476.707575] Subtest sysfs-reader: SUCCESS (3.120s)
[476.805652] [094/132] (548s left) gem_exec_balancer (parallel-contexts)
[477.068878] Starting subtest: parallel-contexts
[480.309986] Subtest parallel-contexts: SUCCESS (3.237s)
[480.540058] [095/132] (544s left) gem_eio (in-flight-internal-1us)
[480.760852] Starting subtest: in-flight-internal-1us
[482.441750] Subtest in-flight-internal-1us: SUCCESS (1.681s)
[482.566637] [096/132] (542s left) vgem_basic (mmap)
[482.611708] Starting subtest: mmap
[482.669058] Subtest mmap: SUCCESS (0.061s)
[482.728246] [097/132] (542s left) gem_ctx_persistence (saturated-hostile-nopreempt)
[482.790989] Starting subtest: saturated-hostile-nopreempt
[482.793877] Starting dynamic subtest: rcs0
[482.852966] Dynamic subtest rcs0: SKIP (0.063s)
[482.865272] Starting dynamic subtest: bcs0
[482.873165] Dynamic subtest bcs0: SKIP (0.017s)
[482.884380] Starting dynamic subtest: vcs0
[482.897274] Dynamic subtest vcs0: SKIP (0.024s)
[482.908225] Starting dynamic subtest: vcs1
[482.916164] Dynamic subtest vcs1: SKIP (0.017s)
[482.927429] Starting dynamic subtest: vecs0
[482.941076] Dynamic subtest vecs0: SKIP (0.023s)
[482.952092] Starting dynamic subtest: ccs0
[482.965988] Dynamic subtest ccs0: SKIP (0.024s)
[482.971707] Subtest saturated-hostile-nopreempt: SKIP (0.177s)
[483.043440] [098/132] (542s left) gem_exec_params (cliprects-invalid)
[483.100939] Starting subtest: cliprects-invalid
[483.103349] Subtest cliprects-invalid: SUCCESS (0.000s)
[483.217178] [099/132] (542s left) perf_pmu (busy)
[483.261785] Starting subtest: busy
[483.264576] Starting dynamic subtest: rcs0
[483.849745] Dynamic subtest rcs0: SUCCESS (0.589s)
[483.862676] Starting dynamic subtest: bcs0
[484.417490] Dynamic subtest bcs0: SUCCESS (0.565s)
[484.430912] Starting dynamic subtest: vcs0
[486.313604] Dynamic subtest vcs0: SUCCESS (1.892s)
[486.333089] Starting dynamic subtest: vcs1
[488.362401] Dynamic subtest vcs1: SUCCESS (2.044s)
[488.376845] Starting dynamic subtest: vecs0
[490.346386] Dynamic subtest vecs0: SUCCESS (1.980s)
[490.360698] Starting dynamic subtest: ccs0
[490.913533] Dynamic subtest ccs0: SUCCESS (0.565s)
[490.916542] Subtest busy: SUCCESS (7.650s)
[491.023049] [100/132] (534s left) gem_create (create-size-update)
[491.081118] Starting subtest: create-size-update
[491.083869] Subtest create-size-update: SUCCESS (0.000s)
[491.299132] [101/132] (534s left) gem_partial_pwrite_pread (writes-after-reads-uncached)
[491.381002] Subtest writes-after-reads-uncached: SKIP (0.000s)
[491.456225] [102/132] (533s left) kms_psr (psr2-suspend)
[491.559184] Starting subtest: psr2-suspend
[491.561617] Starting dynamic subtest: eDP-1
[509.134056] Dynamic subtest eDP-1: SUCCESS (2.911s)
[509.136315] Subtest psr2-suspend: SUCCESS (2.912s)
[510.036557] [103/132] (515s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-shrfb-plflip-blt)
[510.139031] Starting subtest: fbcpsr-2p-primscrn-shrfb-plflip-blt
[510.142912] Subtest fbcpsr-2p-primscrn-shrfb-plflip-blt: SKIP (0.000s)
[510.235754] [104/132] (515s left) kms_properties (plane-properties-legacy)
[510.337819] Starting subtest: plane-properties-legacy
[510.340142] Starting dynamic subtest: pipe-A-eDP-1
[510.897076] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.560s)
[510.908560] Starting dynamic subtest: pipe-B-eDP-1
[512.208823] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.307s)
[512.223193] Starting dynamic subtest: pipe-C-eDP-1
[513.436692] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.229s)
[513.449259] Starting dynamic subtest: pipe-D-eDP-1
[514.679367] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.238s)
[514.681272] Subtest plane-properties-legacy: SUCCESS (4.340s)
[515.481714] [105/132] (510s left) kms_addfb_basic (invalid-get-prop)
[515.539940] Starting subtest: invalid-get-prop
[515.541817] Subtest invalid-get-prop: SUCCESS (0.000s)
[515.680167] [106/132] (509s left) gem_tiled_partial_pwrite_pread (writes)
[515.734487] Subtest writes: SKIP (0.000s)
[515.790875] [107/132] (509s left) kms_flip_scaled_crc (flip-32bpp-yftile-to-32bpp-yftileccs-downscaling)
[515.875910] Starting subtest: flip-32bpp-yftile-to-32bpp-yftileccs-downscaling
[515.880388] Subtest flip-32bpp-yftile-to-32bpp-yftileccs-downscaling: SKIP (0.000s)
[515.952183] [108/132] (509s left) kms_cdclk (mode-transition)
[516.051496] Starting subtest: mode-transition
[516.053682] Starting dynamic subtest: pipe-A-eDP-1
[516.342360] Dynamic subtest pipe-A-eDP-1: SKIP (0.287s)
[516.353588] Starting dynamic subtest: pipe-B-eDP-1
[516.357932] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[516.368504] Starting dynamic subtest: pipe-C-eDP-1
[516.372915] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[516.383250] Starting dynamic subtest: pipe-D-eDP-1
[516.387169] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[516.391099] Subtest mode-transition: SKIP (0.296s)
[517.194469] [109/132] (508s left) syncobj_timeline (invalid-signal-illegal-handle)
[517.260128] Starting subtest: invalid-signal-illegal-handle
[517.262535] Subtest invalid-signal-illegal-handle: SUCCESS (0.000s)
[517.345709] [110/132] (508s left) kms_plane_scaling (planes-downscale-factor-0-75-upscale-factor-0-25)
[517.448938] Starting subtest: planes-downscale-factor-0-75-upscale-factor-0-25
[517.451224] Starting dynamic subtest: pipe-A
[517.511904] Dynamic subtest pipe-A: SUCCESS (0.065s)
[517.522906] Starting dynamic subtest: pipe-B
[518.611267] Dynamic subtest pipe-B: SUCCESS (1.098s)
[518.624492] Starting dynamic subtest: pipe-C
[519.726000] Dynamic subtest pipe-C: SUCCESS (1.113s)
[519.736756] Starting dynamic subtest: pipe-D
[520.875510] Dynamic subtest pipe-D: SUCCESS (1.148s)
[520.877878] Subtest planes-downscale-factor-0-75-upscale-factor-0-25: SUCCESS (3.428s)
[522.021553] [111/132] (503s left) kms_cursor_crc (cursor-offscreen-128x128)
[522.235377] Starting subtest: cursor-offscreen-128x128
[522.241715] Starting dynamic subtest: pipe-A-eDP-1
[524.176005] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.933s)
[524.206707] Starting dynamic subtest: pipe-D-eDP-1
[526.816228] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.615s)
[526.818464] Subtest cursor-offscreen-128x128: SUCCESS (4.577s)
[527.691920] [112/132] (498s left) i915_drm_fdinfo (all-busy-check-all)
[527.735943] Starting subtest: all-busy-check-all
[527.743786] Subtest all-busy-check-all: SKIP (0.004s)
[527.816455] [113/132] (498s left) gem_exec_balancer (nop)
[527.877402] Starting subtest: nop
[574.489773] Subtest nop: SUCCESS (46.598s)
[574.790550] [114/132] (451s left) kms_prop_blob (blob-prop-lifetime)
[574.842571] Starting subtest: blob-prop-lifetime
[574.844889] Subtest blob-prop-lifetime: SUCCESS (0.001s)
[574.940283] [115/132] (451s left) kms_chamelium_hpd (dp-hpd-with-enabled-mode)
[575.324102] Subtest dp-hpd-with-enabled-mode: SKIP (0.000s)
[576.108062] [116/132] (449s left) kms_cursor_legacy (flip-vs-cursor-crc-legacy)
[576.235735] Starting subtest: flip-vs-cursor-crc-legacy
[576.878162] Subtest flip-vs-cursor-crc-legacy: SUCCESS (0.641s)
[577.752064] [117/132] (448s left) gem_mmap_gtt (cpuset-basic-small-copy-xy)
[577.812978] Subtest cpuset-basic-small-copy-XY: SKIP (0.000s)
[577.883144] [118/132] (448s left) kms_scaling_modes (scaling-mode-full)
[577.979956] Starting subtest: scaling-mode-full
[577.982459] Starting dynamic subtest: pipe-A-eDP-1
[578.074665] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.097s)
[578.086094] Starting dynamic subtest: pipe-B-eDP-1
[579.282791] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.206s)
[579.296686] Starting dynamic subtest: pipe-C-eDP-1
[580.398014] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.114s)
[580.415185] Starting dynamic subtest: pipe-D-eDP-1
[581.526716] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.126s)
[581.529216] Subtest scaling-mode-full: SUCCESS (3.551s)
[582.719426] [119/132] (443s left) gem_readwrite (write-bad-handle)
[582.766726] Subtest write-bad-handle: SKIP (0.000s)
[582.834394] [120/132] (443s left) prime_mmap (test_userptr)
[582.893262] Starting subtest: test_userptr
[582.895566] Starting dynamic subtest: test_userptr-smem
[582.897720] Dynamic subtest test_userptr-smem: SUCCESS (0.000s)
[582.899511] Subtest test_userptr: SUCCESS (0.003s)
[583.003872] [121/132] (443s left) gen9_exec_parse (bb-large)
[583.071721] Subtest bb-large: SKIP (0.000s)
[583.146617] [122/132] (443s left) syncobj_timeline (multi-wait-available-signaled)
[583.200893] Starting subtest: multi-wait-available-signaled
[583.203137] Subtest multi-wait-available-signaled: SUCCESS (0.000s)
[583.303669] [123/132] (443s left) gen3_render_mixed_blits
[583.423961] [124/132] (442s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-onoff)
[583.521192] Starting subtest: psr-2p-primscrn-cur-indfb-onoff
[583.525065] Subtest psr-2p-primscrn-cur-indfb-onoff: SKIP (0.000s)
[583.617818] [125/132] (442s left) kms_psr (fbc-pr-suspend)
[583.709460] Starting subtest: fbc-pr-suspend
[583.713189] Subtest fbc-pr-suspend: SKIP (0.000s)
[583.798698] [126/132] (442s left) kms_vrr (flip-basic)
[583.907350] Starting subtest: flip-basic
[583.912623] Subtest flip-basic: SKIP (0.000s)
[583.984262] [127/132] (442s left) kms_busy (extended-modeset-hang-oldfb-with-reset)
[584.100792] Starting subtest: extended-modeset-hang-oldfb-with-reset
[584.102827] Starting dynamic subtest: pipe-A
[595.924427] Dynamic subtest pipe-A: SUCCESS (11.819s)
[595.937867] Starting dynamic subtest: pipe-D
[608.403545] Dynamic subtest pipe-D: SUCCESS (12.475s)
[608.405865] Subtest extended-modeset-hang-oldfb-with-reset: SUCCESS (24.299s)
[609.288219] [128/132] (417s left) kms_content_protection (suspend-resume)
[609.434579] Starting subtest: suspend-resume
[609.439095] Subtest suspend-resume: SKIP (0.000s)
[609.548141] [129/132] (417s left) gem_wait (wait)
[609.613828] Starting subtest: wait
[609.616223] Starting dynamic subtest: all-engines
[610.990886] Dynamic subtest all-engines: SUCCESS (1.375s)
[611.003550] Starting dynamic subtest: rcs0
[612.036188] Dynamic subtest rcs0: SUCCESS (1.044s)
[612.049518] Starting dynamic subtest: bcs0
[613.082926] Dynamic subtest bcs0: SUCCESS (1.045s)
[613.096427] Starting dynamic subtest: vcs0
[614.128055] Dynamic subtest vcs0: SUCCESS (1.043s)
[614.141550] Starting dynamic subtest: vcs1
[615.172781] Dynamic subtest vcs1: SUCCESS (1.042s)
[615.186262] Starting dynamic subtest: vecs0
[616.218070] Dynamic subtest vecs0: SUCCESS (1.043s)
[616.231231] Starting dynamic subtest: ccs0
[617.266021] Dynamic subtest ccs0: SUCCESS (1.045s)
[617.268475] Subtest wait: SUCCESS (7.652s)
[617.462776] [130/132] (409s left) kms_frontbuffer_tracking (psr-rgb565-draw-mmap-wc)
[617.567215] Starting subtest: psr-rgb565-draw-mmap-wc
[624.294607] Subtest psr-rgb565-draw-mmap-wc: SUCCESS (6.729s)
[624.424818] [131/132] (402s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-mmap-cpu)
[624.542196] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-mmap-cpu
[631.043818] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-mmap-cpu: SUCCESS (6.502s)
[631.146976] [132/132] (395s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-render)
[631.247831] Starting subtest: psr-2p-primscrn-pri-indfb-draw-render
[631.252422] Subtest psr-2p-primscrn-pri-indfb-draw-render: SKIP (0.000s)
[631.367175] Closing watchdogs
results: parsing output: 0/ for test: gem_softpin
results: parsing output: 1/ for test: kms_big_fb
results: parsing output: 2/ for test: kms_color
results: parsing output: 3/ for test: prime_vgem
results: parsing output: 4/ for test: kms_ccs
results: parsing output: 5/ for test: kms_psr2_sf
results: parsing output: 6/ for test: kms_pipe_crc_basic
results: parsing output: 7/ for test: kms_frontbuffer_tracking
results: parsing output: 8/ for test: kms_cursor_legacy
results: parsing output: 9/ for test: kms_frontbuffer_tracking
results: parsing output: 10/ for test: perf
results: parsing output: 11/ for test: kms_legacy_colorkey
results: parsing output: 12/ for test: syncobj_timeline
results: parsing output: 13/ for test: core_hotunplug
results: parsing output: 14/ for test: syncobj_eventfd
results: parsing output: 15/ for test: kms_big_fb
results: parsing output: 16/ for test: kms_pm_lpsp
results: parsing output: 17/ for test: gem_mmap_wc
results: parsing output: 18/ for test: kms_flip
results: parsing output: 19/ for test: gem_exec_parallel
results: parsing output: 20/ for test: syncobj_wait
results: parsing output: 21/ for test: gem_workarounds
results: parsing output: 22/ for test: kms_sequence
results: parsing output: 23/ for test: kms_frontbuffer_tracking
results: parsing output: 24/ for test: perf_pmu
results: parsing output: 25/ for test: kms_flip_scaled_crc
results: parsing output: 26/ for test: syncobj_basic
results: parsing output: 27/ for test: kms_ccs
results: parsing output: 28/ for test: i915_pciid
results: parsing output: 29/ for test: perf_pmu
results: parsing output: 30/ for test: kms_frontbuffer_tracking
results: parsing output: 31/ for test: perf
results: parsing output: 32/ for test: gem_lmem_swapping
results: parsing output: 33/ for test: gem_ccs
results: parsing output: 34/ for test: kms_draw_crc
results: parsing output: 35/ for test: kms_rotation_crc
results: parsing output: 36/ for test: gem_mmap_gtt
results: parsing output: 37/ for test: kms_frontbuffer_tracking
results: parsing output: 38/ for test: kms_psr
results: parsing output: 39/ for test: core_getstats
results: parsing output: 40/ for test: kms_hdr
results: parsing output: 41/ for test: kms_frontbuffer_tracking
results: parsing output: 42/ for test: gem_ctx_exec
results: parsing output: 43/ for test: gem_exec_schedule
results: parsing output: 44/ for test: kms_frontbuffer_tracking
results: parsing output: 45/ for test: kms_cursor_crc
results: parsing output: 46/ for test: kms_addfb_basic
results: parsing output: 47/ for test: kms_big_fb
results: parsing output: 48/ for test: kms_big_fb
results: parsing output: 49/ for test: gem_exec_reloc
results: parsing output: 50/ for test: kms_big_fb
results: parsing output: 51/ for test: kms_big_fb
results: parsing output: 52/ for test: kms_psr2_sf
results: parsing output: 53/ for test: kms_dirtyfb
results: parsing output: 54/ for test: kms_chamelium_edid
results: parsing output: 55/ for test: kms_psr
results: parsing output: 56/ for test: kms_frontbuffer_tracking
results: parsing output: 57/ for test: gem_exec_schedule
results: parsing output: 58/ for test: gem_render_copy
results: parsing output: 59/ for test: gem_spin_batch
results: parsing output: 60/ for test: gem_mmap_offset
results: parsing output: 61/ for test: gem_exec_schedule
results: parsing output: 62/ for test: gem_exec_fence
results: parsing output: 63/ for test: kms_flip_scaled_crc
results: parsing output: 64/ for test: kms_cursor_legacy
results: parsing output: 65/ for test: kms_cursor_crc
results: parsing output: 66/ for test: kms_frontbuffer_tracking
results: parsing output: 67/ for test: gem_ctx_sseu
results: parsing output: 68/ for test: kms_frontbuffer_tracking
results: parsing output: 69/ for test: kms_flip
results: parsing output: 70/ for test: api_intel_allocator
results: parsing output: 71/ for test: kms_flip
results: parsing output: 72/ for test: gem_ctx_param
results: parsing output: 73/ for test: gem_ctx_persistence
results: parsing output: 74/ for test: kms_atomic_transition
results: parsing output: 75/ for test: kms_hdr
results: parsing output: 76/ for test: kms_ccs
results: parsing output: 77/ for test: kms_frontbuffer_tracking
results: parsing output: 78/ for test: gem_exec_params
results: parsing output: 79/ for test: gem_pxp
results: parsing output: 80/ for test: sysfs_heartbeat_interval
results: parsing output: 81/ for test: kms_plane_scaling
results: parsing output: 82/ for test: syncobj_timeline
results: parsing output: 83/ for test: gem_softpin
results: parsing output: 84/ for test: kms_plane_cursor
results: parsing output: 85/ for test: kms_cursor_legacy
results: parsing output: 86/ for test: i915_pm_rpm
results: parsing output: 87/ for test: kms_vblank
results: parsing output: 88/ for test: gem_eio
results: parsing output: 89/ for test: kms_ccs
results: parsing output: 90/ for test: kms_flip
results: parsing output: 91/ for test: kms_plane
results: parsing output: 92/ for test: i915_suspend
results: parsing output: 93/ for test: gem_exec_balancer
results: parsing output: 94/ for test: gem_eio
results: parsing output: 95/ for test: vgem_basic
results: parsing output: 96/ for test: gem_ctx_persistence
results: parsing output: 97/ for test: gem_exec_params
results: parsing output: 98/ for test: perf_pmu
results: parsing output: 99/ for test: gem_create
results: parsing output: 100/ for test: gem_partial_pwrite_pread
results: parsing output: 101/ for test: kms_psr
results: parsing output: 102/ for test: kms_frontbuffer_tracking
results: parsing output: 103/ for test: kms_properties
results: parsing output: 104/ for test: kms_addfb_basic
results: parsing output: 105/ for test: gem_tiled_partial_pwrite_pread
results: parsing output: 106/ for test: kms_flip_scaled_crc
results: parsing output: 107/ for test: kms_cdclk
results: parsing output: 108/ for test: syncobj_timeline
results: parsing output: 109/ for test: kms_plane_scaling
results: parsing output: 110/ for test: kms_cursor_crc
results: parsing output: 111/ for test: i915_drm_fdinfo
results: parsing output: 112/ for test: gem_exec_balancer
results: parsing output: 113/ for test: kms_prop_blob
results: parsing output: 114/ for test: kms_chamelium_hpd
results: parsing output: 115/ for test: kms_cursor_legacy
results: parsing output: 116/ for test: gem_mmap_gtt
results: parsing output: 117/ for test: kms_scaling_modes
results: parsing output: 118/ for test: gem_readwrite
results: parsing output: 119/ for test: prime_mmap
results: parsing output: 120/ for test: gen9_exec_parse
results: parsing output: 121/ for test: syncobj_timeline
results: parsing output: 122/ for test: gen3_render_mixed_blits
results: parsing output: 123/ for test: kms_frontbuffer_tracking
results: parsing output: 124/ for test: kms_psr
results: parsing output: 125/ for test: kms_vrr
results: parsing output: 126/ for test: kms_busy
results: parsing output: 127/ for test: kms_content_protection
results: parsing output: 128/ for test: gem_wait
results: parsing output: 129/ for test: kms_frontbuffer_tracking
results: parsing output: 130/ for test: kms_frontbuffer_tracking
results: parsing output: 131/ for test: kms_frontbuffer_tracking
Done.