[58.689927] Initializing watchdogs
[58.689970]   /dev/watchdog0
[58.704034] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7dd5 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Graphics]
[58.707767] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[58.709925] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[58.713217] [001/133] (960s left) kms_feature_discovery (display-2x)
[58.804899] Starting subtest: display-2x
[58.809470] Subtest display-2x: SKIP (0.000s)
[58.869779] [002/133] (960s left) perf (polling)
[58.996676] Starting subtest: polling
[58.998666] Starting dynamic subtest: 0-rcs0
[69.029046] Dynamic subtest 0-rcs0: SUCCESS (10.072s)
[69.035786] Starting dynamic subtest: 1-vecs0
[79.065604] Dynamic subtest 1-vecs0: SUCCESS (10.047s)
[79.068078] Subtest polling: SUCCESS (20.120s)
[79.110744] [003/133] (940s left) kms_content_protection (lic-type-1)
[79.240192] Starting subtest: lic-type-1
[79.244765] Subtest lic-type-1: SKIP (0.000s)
[79.356202] [004/133] (939s left) kms_flip (flip-vs-panning-vs-hang)
[79.432727] Starting subtest: flip-vs-panning-vs-hang
[79.434703] Starting dynamic subtest: A-eDP1
[131.434653] Dynamic subtest A-eDP1: SUCCESS (51.999s)
[131.443995] Starting dynamic subtest: D-eDP1
[181.321479] Dynamic subtest D-eDP1: SUCCESS (49.884s)
[181.324514] Subtest flip-vs-panning-vs-hang: SUCCESS (101.886s)
[182.507146] [005/133] (836s left) gem_ctx_persistence (legacy-engines-queued)
[182.570683] Starting subtest: legacy-engines-queued
[182.572662] Starting dynamic subtest: render
[182.644535] Dynamic subtest render: SUCCESS (0.076s)
[182.654556] Starting dynamic subtest: bsd1
[183.800429] Dynamic subtest bsd1: SUCCESS (1.152s)
[183.811243] Starting dynamic subtest: bsd2
[185.782823] Dynamic subtest bsd2: SUCCESS (1.981s)
[185.793655] Starting dynamic subtest: blt
[185.834784] Dynamic subtest blt: SUCCESS (0.051s)
[185.844333] Starting dynamic subtest: vebox
[187.831361] Dynamic subtest vebox: SUCCESS (1.994s)
[187.834314] Subtest legacy-engines-queued: SUCCESS (5.262s)
[187.911410] [006/133] (831s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-cpu)
[188.001460] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-cpu
[188.005524] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[188.074612] [007/133] (831s left) gem_pxp (verify-pxp-stale-buf-optout-execution)
[188.192797] Starting subtest: verify-pxp-stale-buf-optout-execution
[189.257286] Subtest verify-pxp-stale-buf-optout-execution: SUCCESS (1.066s)
[189.375752] [008/133] (830s left) gem_softpin (allocator-nopin)
[189.425868] Starting subtest: allocator-nopin
[189.516544] Subtest allocator-nopin: SUCCESS (0.091s)
[189.637942] [009/133] (829s left) gem_ccs (suspend-resume)
[189.708994] Starting subtest: suspend-resume
[189.713647] Subtest suspend-resume: SKIP (0.000s)
[189.810316] [010/133] (829s left) sysfs_timeslice_duration (duration)
[189.880312] Starting subtest: duration
[189.882207] Starting dynamic subtest: vecs0
[203.832615] Dynamic subtest vecs0: SUCCESS (13.951s)
[203.844268] Starting dynamic subtest: ccs0
[216.993066] Dynamic subtest ccs0: SUCCESS (13.161s)
[217.003428] Starting dynamic subtest: vcs0
[230.839620] Dynamic subtest vcs0: SUCCESS (13.842s)
[230.849029] Starting dynamic subtest: bcs0
[243.982831] Dynamic subtest bcs0: SUCCESS (13.144s)
[243.993577] Starting dynamic subtest: rcs0
[257.140874] Dynamic subtest rcs0: SUCCESS (13.156s)
[257.151086] Starting dynamic subtest: vcs1
[270.839965] Dynamic subtest vcs1: SUCCESS (13.696s)
[270.843124] Subtest duration: SUCCESS (80.958s)
[270.919587] [011/133] (748s left) kms_psr (fbc-psr-cursor-mmap-gtt)
[270.998857] Starting subtest: fbc-psr-cursor-mmap-gtt
[271.001145] Starting dynamic subtest: eDP-1
[271.005277] Dynamic subtest eDP-1: SKIP (0.000s)
[271.009405] Subtest fbc-psr-cursor-mmap-gtt: SKIP (0.000s)
[271.068274] [012/133] (748s left) kms_busy (extended-pageflip-hang-oldfb)
[271.153575] Starting subtest: extended-pageflip-hang-oldfb
[271.155903] Starting dynamic subtest: pipe-A
[271.570210] Dynamic subtest pipe-A: SUCCESS (0.417s)
[271.579938] Starting dynamic subtest: pipe-D
[272.724502] Dynamic subtest pipe-D: SUCCESS (1.151s)
[272.726879] Subtest extended-pageflip-hang-oldfb: SUCCESS (1.571s)
[273.584906] [013/133] (746s left) gem_exec_fence (submit67)
[273.760967] Starting subtest: submit67
[273.765506] Subtest submit67: SKIP (0.000s)
[275.915781] [FACT gem_exec_fence (submit67)] new: kernel.kmod_is_loaded.vgem: true
[275.918847] [014/133] (743s left) kms_big_fb (4-tiled-16bpp-rotate-0)
[276.001500] Starting subtest: 4-tiled-16bpp-rotate-0
[277.235823] Subtest 4-tiled-16bpp-rotate-0: SUCCESS (1.235s)
[277.367875] [015/133] (742s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-cpu)
[277.454897] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-cpu
[277.458351] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[277.545842] [016/133] (742s left) gem_exec_reloc (basic-gtt-wc-noreloc)
[277.614160] Subtest basic-gtt-wc-noreloc: SKIP (0.000s)
[277.688805] [017/133] (742s left) syncobj_timeline (signal-point-0)
[277.748164] Starting subtest: signal-point-0
[277.750238] Subtest signal-point-0: SUCCESS (0.000s)
[277.847646] [018/133] (741s left) kms_cursor_legacy (cursor-vs-flip-legacy)
[277.950288] Starting subtest: cursor-vs-flip-legacy
[307.311796] Subtest cursor-vs-flip-legacy: SUCCESS (29.359s)
[308.121924] [019/133] (711s left) kms_chamelium_hpd (dp-hpd-for-each-pipe)
[308.504374] Subtest dp-hpd-for-each-pipe: SKIP (0.000s)
[309.315562] [020/133] (710s left) gem_workarounds (basic-read)
[309.382098] Starting subtest: basic-read
[309.393272] Subtest basic-read: SUCCESS (0.012s)
[309.506505] [021/133] (710s left) perf (oa-formats)
[309.595870] Starting subtest: oa-formats
[309.598222] Starting dynamic subtest: 0-rcs0
[309.609534] Dynamic subtest 0-rcs0: SUCCESS (0.013s)
[309.618889] Starting dynamic subtest: 1-vcs1
[309.631328] Dynamic subtest 1-vcs1: SUCCESS (0.022s)
[309.633671] Subtest oa-formats: SUCCESS (0.035s)
[309.669224] [022/133] (710s left) kms_plane_scaling (planes-downscale-factor-0-75-upscale-factor-0-25)
[309.736190] Starting subtest: planes-downscale-factor-0-75-upscale-factor-0-25
[309.738639] Starting dynamic subtest: pipe-A
[309.799172] Dynamic subtest pipe-A: SUCCESS (0.064s)
[309.808888] Starting dynamic subtest: pipe-B
[310.959221] Dynamic subtest pipe-B: SUCCESS (1.160s)
[310.969536] Starting dynamic subtest: pipe-C
[312.081932] Dynamic subtest pipe-C: SUCCESS (1.122s)
[312.092225] Starting dynamic subtest: pipe-D
[313.207029] Dynamic subtest pipe-D: SUCCESS (1.125s)
[313.209426] Subtest planes-downscale-factor-0-75-upscale-factor-0-25: SUCCESS (3.473s)
[314.354936] [023/133] (705s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-pwrite)
[314.435749] Starting subtest: psr-1p-primscrn-cur-indfb-draw-pwrite
[321.283042] Subtest psr-1p-primscrn-cur-indfb-draw-pwrite: SUCCESS (6.850s)
[321.396363] [024/133] (698s left) syncobj_timeline (invalid-transfer-non-existent-point)
[321.444059] Starting subtest: invalid-transfer-non-existent-point
[321.446424] Subtest invalid-transfer-non-existent-point: SUCCESS (0.000s)
[321.531865] [025/133] (698s left) syncobj_wait (wait-for-submit-complex)
[321.595321] Starting subtest: wait-for-submit-complex
[321.658051] Subtest wait-for-submit-complex: SUCCESS (0.062s)
[321.745211] [026/133] (698s left) syncobj_timeline (multi-wait-available-submitted-signaled)
[321.796742] Starting subtest: multi-wait-available-submitted-signaled
[321.799093] Subtest multi-wait-available-submitted-signaled: SUCCESS (0.000s)
[321.902697] [027/133] (698s left) kms_color_pipeline (plane-lut1d-pre-ctm3x4)
[321.973268] Starting subtest: plane-lut1d-pre-ctm3x4
[322.097535] Starting dynamic subtest: pipe-A-plane-0
[322.391449] Dynamic subtest pipe-A-plane-0: FAIL (0.151s)
[322.400398] Starting dynamic subtest: pipe-A-plane-1
[322.582271] Dynamic subtest pipe-A-plane-1: FAIL (0.156s)
[322.590790] Starting dynamic subtest: pipe-A-plane-2
[322.799698] Dynamic subtest pipe-A-plane-2: FAIL (0.167s)
[323.758678] Starting dynamic subtest: pipe-B-plane-0
[324.182917] Dynamic subtest pipe-B-plane-0: FAIL (0.152s)
[324.192490] Starting dynamic subtest: pipe-B-plane-1
[324.507386] Dynamic subtest pipe-B-plane-1: FAIL (0.156s)
[324.517823] Starting dynamic subtest: pipe-B-plane-2
[324.827020] Dynamic subtest pipe-B-plane-2: FAIL (0.632s)
[325.894229] Starting dynamic subtest: pipe-C-plane-0
[326.400514] Dynamic subtest pipe-C-plane-0: FAIL (0.140s)
[326.410614] Starting dynamic subtest: pipe-C-plane-1
[326.810470] Dynamic subtest pipe-C-plane-1: FAIL (0.610s)
[326.817932] Starting dynamic subtest: pipe-C-plane-2
[327.174982] Dynamic subtest pipe-C-plane-2: FAIL (0.146s)
[328.035150] Starting dynamic subtest: pipe-D-plane-0
[328.638052] Dynamic subtest pipe-D-plane-0: FAIL (0.140s)
[328.647646] Starting dynamic subtest: pipe-D-plane-1
[329.103642] Dynamic subtest pipe-D-plane-1: FAIL (0.623s)
[329.112586] Starting dynamic subtest: pipe-D-plane-2
[329.542021] Dynamic subtest pipe-D-plane-2: FAIL (0.563s)
[329.657088] Subtest plane-lut1d-pre-ctm3x4: FAIL (7.685s)
[330.483825] [028/133] (689s left) kms_frontbuffer_tracking (fbc-1p-primscrn-shrfb-msflip-blt)
[330.561815] Starting subtest: fbc-1p-primscrn-shrfb-msflip-blt
[335.085763] Subtest fbc-1p-primscrn-shrfb-msflip-blt: SUCCESS (4.528s)
[336.286921] [029/133] (683s left) gem_mmap (big-bo)
[336.346420] Subtest big-bo: SKIP (0.000s)
[336.409936] [030/133] (683s left) syncobj_eventfd (invalid-bad-pad)
[336.461144] Starting subtest: invalid-bad-pad
[336.463329] Subtest invalid-bad-pad: SUCCESS (0.000s)
[336.559944] [031/133] (683s left) kms_lease (lease-unleased-crtc)
[336.647859] Starting subtest: lease-unleased-crtc
[336.650143] Starting dynamic subtest: pipe-A-eDP-1
[336.935852] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.286s)
[336.944632] Starting dynamic subtest: pipe-B-eDP-1
[337.732154] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.795s)
[337.741680] Starting dynamic subtest: pipe-C-eDP-1
[337.743909] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.004s)
[337.750972] Starting dynamic subtest: pipe-D-eDP-1
[337.752864] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.004s)
[337.754782] Subtest lease-unleased-crtc: SUCCESS (1.095s)
[338.093355] [032/133] (682s left) i915_pm_rpm (gem-execbuf)
[340.011231] Starting subtest: gem-execbuf
[340.013668] Starting dynamic subtest: smem0
[341.725514] Dynamic subtest smem0: SUCCESS (1.717s)
[341.727741] Subtest gem-execbuf: SUCCESS (1.718s)
[341.810826] [033/133] (678s left) kms_cursor_crc (cursor-rapid-movement-max-size)
[342.100056] Starting subtest: cursor-rapid-movement-max-size
[342.106320] Subtest cursor-rapid-movement-max-size: SKIP (0.000s)
[342.230077] [034/133] (678s left) kms_plane_scaling (plane-scaler-with-clipping-clamping-pixel-formats)
[342.300671] Starting subtest: plane-scaler-with-clipping-clamping-pixel-formats
[342.302806] Starting dynamic subtest: pipe-A
[342.410986] Dynamic subtest pipe-A: SKIP (0.106s)
[342.419414] Starting dynamic subtest: pipe-B
[343.574541] Dynamic subtest pipe-B: SKIP (1.163s)
[343.584948] Starting dynamic subtest: pipe-C
[344.793326] Dynamic subtest pipe-C: SUCCESS (1.223s)
[344.802615] Starting dynamic subtest: pipe-D
[345.937383] Dynamic subtest pipe-D: SUCCESS (1.144s)
[345.939678] Subtest plane-scaler-with-clipping-clamping-pixel-formats: SUCCESS (3.639s)
[347.142570] [035/133] (673s left) kms_vrr (max-min)
[347.217193] Starting subtest: max-min
[347.223782] Subtest max-min: SKIP (0.000s)
[347.286521] [036/133] (673s left) gem_userptr_blits (vma-merge)
[347.354060] Starting subtest: vma-merge
[347.392115] Subtest vma-merge: SUCCESS (0.038s)
[347.504912] [037/133] (673s left) syncobj_timeline (host-signal-ordered)
[347.565078] Starting subtest: host-signal-ordered
[347.567424] Subtest host-signal-ordered: SUCCESS (0.000s)
[347.662240] [038/133] (672s left) kms_frontbuffer_tracking (psr-rgb565-draw-blt)
[347.751814] Starting subtest: psr-rgb565-draw-blt
[354.721513] Subtest psr-rgb565-draw-blt: SUCCESS (6.973s)
[354.848681] [039/133] (665s left) gen9_exec_parse (bb-start-param)
[354.912220] Subtest bb-start-param: SKIP (0.000s)
[354.986428] [040/133] (665s left) kms_psr (psr2-cursor-mmap-cpu)
[355.057842] Starting subtest: psr2-cursor-mmap-cpu
[355.060149] Starting dynamic subtest: eDP-1
[356.747044] Dynamic subtest eDP-1: SUCCESS (1.686s)
[356.749058] Subtest psr2-cursor-mmap-cpu: SUCCESS (1.687s)
[357.609361] [041/133] (663s left) core_setmaster (master-drop-set-user)
[357.707348] Starting subtest: master-drop-set-user
[357.735591] Subtest master-drop-set-user: SUCCESS (0.028s)
[357.773787] [042/133] (663s left) kms_psr2_sf (fbc-psr2-overlay-plane-move-continuous-exceed-fully-sf)
[357.856959] Starting subtest: fbc-psr2-overlay-plane-move-continuous-exceed-fully-sf
[357.859184] Starting dynamic subtest: pipe-A-eDP-1
[357.955352] Dynamic subtest pipe-A-eDP-1: SKIP (0.100s)
[357.964194] Starting dynamic subtest: pipe-B-eDP-1
[359.094275] Dynamic subtest pipe-B-eDP-1: SKIP (1.136s)
[359.098635] Subtest fbc-psr2-overlay-plane-move-continuous-exceed-fully-sf: SKIP (1.239s)
[360.284149] [043/133] (660s left) gem_mmap_gtt (basic-copy)
[360.352742] Subtest basic-copy: SKIP (0.000s)
[360.414365] [044/133] (660s left) kms_vrr (flip-dpms)
[360.494776] Starting subtest: flip-dpms
[360.501102] Subtest flip-dpms: SKIP (0.000s)
[360.565754] [045/133] (660s left) kms_cursor_legacy (short-busy-flip-before-cursor-toggle)
[360.664793] Starting subtest: short-busy-flip-before-cursor-toggle
[360.669098] Subtest short-busy-flip-before-cursor-toggle: SKIP (0.000s)
[360.809134] [046/133] (660s left) kms_flip (2x-wf_vblank-ts-check-interruptible)
[360.881891] Starting subtest: 2x-wf_vblank-ts-check-interruptible
[360.892744] Subtest 2x-wf_vblank-ts-check-interruptible: SKIP (0.010s)
[360.967108] [047/133] (660s left) kms_plane (pixel-format-yf-tiled-modifier-source-clamping)
[361.037711] Starting subtest: pixel-format-yf-tiled-modifier-source-clamping
[361.041592] Subtest pixel-format-yf-tiled-modifier-source-clamping: SKIP (0.000s)
[361.109545] [048/133] (659s left) i915_module_load (reload-no-display)
[361.148863] Starting subtest: reload-no-display
[366.957863] Subtest reload-no-display: SUCCESS (5.810s)
[366.987352] [FACT i915_module_load (reload-no-display)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[366.988054] [FACT i915_module_load (reload-no-display)] deleted: kernel.kmod_is_loaded.i915: true
[366.991291] [049/133] (654s left) i915_pm_rps (thresholds-park)
[368.504669] Starting subtest: thresholds-park
[368.509139] Subtest thresholds-park: SKIP (0.002s)
[368.543941] [FACT i915_pm_rps (thresholds-park)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[368.545140] [FACT i915_pm_rps (thresholds-park)] new: kernel.kmod_is_loaded.i915: true
[368.549520] [050/133] (652s left) kms_psr_stress_test (flip-primary-invalidate-overlay)
[368.631155] Starting subtest: flip-primary-invalidate-overlay
[380.261246] Subtest flip-primary-invalidate-overlay: SUCCESS (11.631s)
[380.407474] [051/133] (640s left) kms_big_fb (4-tiled-8bpp-rotate-270)
[380.505922] Starting subtest: 4-tiled-8bpp-rotate-270
[380.526235] Subtest 4-tiled-8bpp-rotate-270: SKIP (0.020s)
[380.638935] [052/133] (640s left) gem_gpgpu_fill (basic)
[380.689457] Starting subtest: basic
[380.691416] Starting dynamic subtest: smem
[380.695564] Dynamic subtest smem: SUCCESS (0.007s)
[380.697388] Subtest basic: SUCCESS (0.007s)
[380.813613] [053/133] (640s left) kms_sequence (queue-busy)
[380.887075] Starting subtest: queue-busy
[380.888999] Starting dynamic subtest: pipe-A-eDP-1
[382.829964] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.940s)
[382.838047] Starting dynamic subtest: pipe-B-eDP-1
[385.457405] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.628s)
[385.465768] Starting dynamic subtest: pipe-C-eDP-1
[388.074588] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.614s)
[388.083584] Starting dynamic subtest: pipe-D-eDP-1
[390.632340] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.557s)
[390.634582] Subtest queue-busy: SUCCESS (9.745s)
[391.516383] [054/133] (629s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-indfb-pgflip-blt)
[391.599449] Starting subtest: fbcpsr-2p-primscrn-indfb-pgflip-blt
[391.603544] Subtest fbcpsr-2p-primscrn-indfb-pgflip-blt: SKIP (0.000s)
[391.694570] [055/133] (629s left) syncobj_wait (invalid-signal-illegal-handle)
[391.752771] Starting subtest: invalid-signal-illegal-handle
[391.754919] Subtest invalid-signal-illegal-handle: SUCCESS (0.000s)
[391.857480] [056/133] (629s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-mmap-gtt)
[391.934965] Starting subtest: psr-2p-primscrn-spr-indfb-draw-mmap-gtt
[391.939710] Subtest psr-2p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[392.024020] [057/133] (629s left) gem_mmap_wc (read-write-distinct)
[392.089470] Subtest read-write-distinct: SKIP (0.000s)
[392.147692] [058/133] (629s left) prime_vgem (shrink)
[392.225827] Starting subtest: shrink
[392.242473] Subtest shrink: SUCCESS (0.016s)
[392.355215] [059/133] (629s left) api_intel_bb (blit-noreloc-keep-cache)
[392.413619] Starting subtest: blit-noreloc-keep-cache
[392.422081] Subtest blit-noreloc-keep-cache: SUCCESS (0.010s)
[392.554314] [060/133] (628s left) vgem_basic (mmap)
[392.595383] Starting subtest: mmap
[392.601166] Subtest mmap: SUCCESS (0.010s)
[392.663170] [061/133] (628s left) perf (invalid-oa-metric-set-id)
[392.778789] Starting subtest: invalid-oa-metric-set-id
[392.792331] Subtest invalid-oa-metric-set-id: SUCCESS (0.013s)
[392.836751] [062/133] (628s left) kms_ccs (bad-pixel-format-4-tiled-dg2-rc-ccs)
[392.903537] Starting subtest: bad-pixel-format-4-tiled-dg2-rc-ccs
[392.905554] Starting dynamic subtest: pipe-A-eDP-1
[392.924910] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[392.937693] Starting dynamic subtest: pipe-B-eDP-1
[392.955913] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[392.963080] Starting dynamic subtest: pipe-C-eDP-1
[392.980910] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[392.987903] Starting dynamic subtest: pipe-D-eDP-1
[393.006306] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[393.009918] Subtest bad-pixel-format-4-tiled-dg2-rc-ccs: SKIP (0.004s)
[395.087778] [063/133] (626s left) kms_big_fb (linear-16bpp-rotate-270)
[395.182784] Starting subtest: linear-16bpp-rotate-270
[395.206098] Subtest linear-16bpp-rotate-270: SKIP (0.020s)
[395.317289] [064/133] (626s left) kms_flip (2x-absolute-wf_vblank)
[395.397780] Starting subtest: 2x-absolute-wf_vblank
[395.404543] Subtest 2x-absolute-wf_vblank: SKIP (0.008s)
[395.483097] [065/133] (626s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-mmap-cpu)
[395.574073] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-mmap-cpu
[399.865270] Subtest fbc-1p-primscrn-pri-shrfb-draw-mmap-cpu: SUCCESS (4.295s)
[401.007512] [066/133] (620s left) gem_exec_whisper (basic-forked)
[401.071522] Starting subtest: basic-forked
[408.844060] Subtest basic-forked: SUCCESS (7.773s)
[409.046355] [067/133] (612s left) kms_chamelium_audio (dp-audio-edid)
[409.416561] Subtest dp-audio-edid: SKIP (0.000s)
[410.199522] [068/133] (611s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-32bpp-4tile-upscaling)
[410.268997] Starting subtest: flip-64bpp-4tile-to-32bpp-4tile-upscaling
[410.274241] Starting dynamic subtest: pipe-A-default-mode
[413.097661] Dynamic subtest pipe-A-default-mode: SUCCESS (2.824s)
[413.099952] Subtest flip-64bpp-4tile-to-32bpp-4tile-upscaling: SUCCESS (2.828s)
[413.922407] [069/133] (607s left) kms_plane_cursor (primary)
[413.989988] Starting subtest: primary
[413.994529] Starting dynamic subtest: pipe-A-eDP-1-size-64
[416.567219] Dynamic subtest pipe-A-eDP-1-size-64: SUCCESS (2.579s)
[416.624917] Starting dynamic subtest: pipe-A-eDP-1-size-128
[419.178901] Dynamic subtest pipe-A-eDP-1-size-128: SUCCESS (2.562s)
[419.201261] Starting dynamic subtest: pipe-A-eDP-1-size-256
[421.800567] Dynamic subtest pipe-A-eDP-1-size-256: SUCCESS (2.604s)
[422.115814] Starting dynamic subtest: pipe-B-eDP-1-size-64
[425.425072] Dynamic subtest pipe-B-eDP-1-size-64: SUCCESS (3.319s)
[425.449335] Starting dynamic subtest: pipe-B-eDP-1-size-128
[428.025699] Dynamic subtest pipe-B-eDP-1-size-128: SUCCESS (2.583s)
[428.049557] Starting dynamic subtest: pipe-B-eDP-1-size-256
[430.605168] Dynamic subtest pipe-B-eDP-1-size-256: SUCCESS (2.561s)
[430.923475] Starting dynamic subtest: pipe-C-eDP-1-size-64
[433.893034] Dynamic subtest pipe-C-eDP-1-size-64: SUCCESS (2.981s)
[433.919297] Starting dynamic subtest: pipe-C-eDP-1-size-128
[436.093396] Dynamic subtest pipe-C-eDP-1-size-128: SUCCESS (2.180s)
[436.125295] Starting dynamic subtest: pipe-C-eDP-1-size-256
[438.316404] Dynamic subtest pipe-C-eDP-1-size-256: SUCCESS (2.203s)
[438.636780] Starting dynamic subtest: pipe-D-eDP-1-size-64
[441.503365] Dynamic subtest pipe-D-eDP-1-size-64: SUCCESS (2.877s)
[441.539045] Starting dynamic subtest: pipe-D-eDP-1-size-128
[443.726296] Dynamic subtest pipe-D-eDP-1-size-128: SUCCESS (2.203s)
[443.752204] Starting dynamic subtest: pipe-D-eDP-1-size-256
[445.926484] Dynamic subtest pipe-D-eDP-1-size-256: SUCCESS (2.181s)
[446.230509] Subtest primary: SUCCESS (32.241s)
[447.055761] [070/133] (574s left) gen9_exec_parse (shadow-peek)
[447.115152] Subtest shadow-peek: SKIP (0.000s)
[447.179885] [071/133] (574s left) gem_mmap_gtt (close-race)
[447.244352] Subtest close-race: SKIP (0.000s)
[447.298086] [072/133] (574s left) gem_workarounds (reset-fd)
[447.364184] Starting subtest: reset-fd
[447.552958] Subtest reset-fd: SUCCESS (0.189s)
[447.678573] [073/133] (574s left) kms_atomic_transition (plane-primary-toggle-with-vblank-wait)
[447.771249] Starting subtest: plane-primary-toggle-with-vblank-wait
[447.773092] Starting dynamic subtest: pipe-A-eDP-1
[447.950962] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.180s)
[448.258889] Starting dynamic subtest: pipe-B-eDP-1
[449.161277] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.911s)
[449.459782] Subtest plane-primary-toggle-with-vblank-wait: SUCCESS (1.690s)
[450.323931] [074/133] (571s left) kms_fbcon_fbt (psr)
[450.378429] Starting subtest: psr
[457.759390] Subtest psr: SUCCESS (7.376s)
[457.833225] [075/133] (564s left) kms_psr (fbc-pr-basic)
[457.914119] Starting subtest: fbc-pr-basic
[457.918316] Subtest fbc-pr-basic: SKIP (0.000s)
[457.989999] [076/133] (564s left) kms_psr (pr-primary-blt)
[458.065773] Starting subtest: pr-primary-blt
[458.070295] Subtest pr-primary-blt: SKIP (0.000s)
[458.138168] [077/133] (564s left) gem_exec_balancer (full-pulse)
[458.203468] Starting subtest: full-pulse
[462.690585] Subtest full-pulse: SUCCESS (4.487s)
[463.013617] [078/133] (559s left) gem_exec_schedule (implicit-write-read)
[463.087205] Starting subtest: implicit-write-read
[463.089300] Starting dynamic subtest: rcs0
[463.251984] Dynamic subtest rcs0: SUCCESS (0.174s)
[463.263836] Starting dynamic subtest: vcs0
[463.362550] Dynamic subtest vcs0: SUCCESS (0.110s)
[463.374943] Starting dynamic subtest: vcs1
[463.491300] Dynamic subtest vcs1: SUCCESS (0.128s)
[463.502087] Starting dynamic subtest: vecs0
[463.595246] Dynamic subtest vecs0: SUCCESS (0.103s)
[463.605929] Starting dynamic subtest: ccs0
[463.727040] Dynamic subtest ccs0: SUCCESS (0.131s)
[463.729702] Subtest implicit-write-read: SUCCESS (0.650s)
[464.960436] [079/133] (557s left) kms_rotation_crc (sprite-rotation-90)
[465.034238] Starting subtest: sprite-rotation-90
[465.038604] Subtest sprite-rotation-90: SKIP (0.001s)
[465.107531] [080/133] (557s left) kms_feature_discovery (psr2)
[465.175785] Starting subtest: psr2
[465.178365] Subtest psr2: SUCCESS (0.000s)
[465.260559] [081/133] (557s left) gem_softpin (overlap)
[465.320071] Starting subtest: overlap
[466.235553] Subtest overlap: SUCCESS (0.918s)
[466.381682] [082/133] (555s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-180-async-flip)
[466.461890] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-180-async-flip
[466.466322] Subtest yf-tiled-max-hw-stride-32bpp-rotate-180-async-flip: SKIP (0.000s)
[466.548621] [083/133] (555s left) perf_pmu (event-wait)
[466.588289] Starting subtest: event-wait
[466.590650] Starting dynamic subtest: rcs0
[466.595139] Dynamic subtest rcs0: SKIP (0.000s)
[466.599273] Subtest event-wait: SKIP (0.001s)
[466.691956] [084/133] (555s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-pwrite)
[466.774611] Starting subtest: psr-2p-primscrn-cur-indfb-draw-pwrite
[466.778905] Subtest psr-2p-primscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[466.871049] [085/133] (555s left) kms_frontbuffer_tracking (fbcpsr-2p-shrfb-fliptrack-mmap-gtt)
[466.956262] Starting subtest: fbcpsr-2p-shrfb-fliptrack-mmap-gtt
[466.960580] Subtest fbcpsr-2p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s)
[467.056729] [086/133] (555s left) kms_flip (2x-plain-flip-interruptible)
[467.136734] Starting subtest: 2x-plain-flip-interruptible
[467.146258] Subtest 2x-plain-flip-interruptible: SKIP (0.008s)
[467.254059] [087/133] (555s left) kms_addfb_basic (addfb25-yf-tiled-legacy)
[467.333928] Starting subtest: addfb25-yf-tiled-legacy
[467.335533] Subtest addfb25-yf-tiled-legacy: SUCCESS (0.000s)
[467.445792] [088/133] (555s left) api_intel_bb (reset-flags)
[467.491574] Starting subtest: reset-flags
[467.498467] Subtest reset-flags: SUCCESS (0.009s)
[467.616302] [089/133] (555s left) gem_sync (basic-many-each)
[467.689011] Starting subtest: basic-many-each
[470.005901] Subtest basic-many-each: SUCCESS (2.319s)
[470.193606] [090/133] (552s left) kms_psr2_sf (fbc-pr-overlay-primary-update-sf-dmg-area)
[470.272720] Starting subtest: fbc-pr-overlay-primary-update-sf-dmg-area
[470.277060] Subtest fbc-pr-overlay-primary-update-sf-dmg-area: SKIP (0.000s)
[470.344329] [091/133] (552s left) gem_exec_schedule (preempt-user)
[470.410493] Starting subtest: preempt-user
[470.412420] Starting dynamic subtest: rcs0
[470.427336] Dynamic subtest rcs0: SUCCESS (0.025s)
[470.437743] Starting dynamic subtest: bcs0
[470.451947] Dynamic subtest bcs0: SUCCESS (0.024s)
[470.460671] Starting dynamic subtest: vcs0
[470.472403] Dynamic subtest vcs0: SUCCESS (0.020s)
[470.481170] Starting dynamic subtest: vcs1
[470.494780] Dynamic subtest vcs1: SUCCESS (0.021s)
[470.503629] Starting dynamic subtest: vecs0
[470.515289] Dynamic subtest vecs0: SUCCESS (0.019s)
[470.524797] Starting dynamic subtest: ccs0
[470.535711] Dynamic subtest ccs0: SUCCESS (0.020s)
[470.538071] Subtest preempt-user: SUCCESS (0.134s)
[471.905312] [092/133] (550s left) gem_busy (semaphore)
[472.089860] Subtest semaphore: SKIP (0.000s)
[472.315240] [093/133] (550s left) kms_pm_rpm (legacy-planes-dpms)
[474.022753] Starting subtest: legacy-planes-dpms
[474.024951] Starting dynamic subtest: plane-64
[482.260388] Dynamic subtest plane-64: SUCCESS (8.240s)
[482.271616] Starting dynamic subtest: plane-94
[490.540098] Dynamic subtest plane-94: SUCCESS (8.280s)
[490.550598] Starting dynamic subtest: plane-124
[498.846685] Dynamic subtest plane-124: SUCCESS (8.304s)
[498.857838] Starting dynamic subtest: plane-134
[507.132786] Dynamic subtest plane-134: SUCCESS (8.283s)
[507.135834] Subtest legacy-planes-dpms: SUCCESS (33.116s)
[507.506268] [094/133] (515s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-16bpp-ytile-downscaling)
[507.581039] Starting subtest: flip-64bpp-ytile-to-16bpp-ytile-downscaling
[507.585629] Subtest flip-64bpp-ytile-to-16bpp-ytile-downscaling: SKIP (0.000s)
[507.668564] [095/133] (515s left) kms_rotation_crc (primary-x-tiled-reflect-x-0)
[507.737799] Starting subtest: primary-x-tiled-reflect-x-0
[514.546517] Subtest primary-x-tiled-reflect-x-0: SUCCESS (6.809s)
[515.780877] [096/133] (507s left) kms_hdr (bpc-switch-dpms)
[515.858062] Starting subtest: bpc-switch-dpms
[516.937586] Starting dynamic subtest: pipe-A-eDP-1
[521.464073] Dynamic subtest pipe-A-eDP-1: SUCCESS (4.528s)
[521.466438] Subtest bpc-switch-dpms: SUCCESS (5.608s)
[521.578320] [097/133] (501s left) gem_mmap_wc (bad-object)
[521.639069] Subtest bad-object: SKIP (0.000s)
[521.706777] [098/133] (501s left) kms_ccs (crc-primary-rotation-180-y-tiled-gen12-mc-ccs)
[521.776800] Starting subtest: crc-primary-rotation-180-y-tiled-gen12-mc-ccs
[521.779194] Starting dynamic subtest: pipe-A-eDP-1
[521.801598] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[521.812073] Starting dynamic subtest: pipe-B-eDP-1
[521.833246] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[521.841275] Starting dynamic subtest: pipe-C-eDP-1
[521.861477] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[521.869446] Starting dynamic subtest: pipe-D-eDP-1
[521.891287] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[521.895643] Subtest crc-primary-rotation-180-y-tiled-gen12-mc-ccs: SKIP (0.006s)
[524.297931] [099/133] (498s left) prime_mmap (test_forked)
[524.352748] Starting subtest: test_forked
[524.355104] Starting dynamic subtest: test_forked-smem
[524.391448] Dynamic subtest test_forked-smem: SUCCESS (0.040s)
[524.394074] Subtest test_forked: SUCCESS (0.041s)
[524.486435] [100/133] (498s left) kms_cursor_legacy (cursorb-vs-flipa-legacy)
[524.585556] Starting subtest: cursorB-vs-flipA-legacy
[524.589942] Subtest cursorB-vs-flipA-legacy: SKIP (0.001s)
[524.741404] [101/133] (498s left) kms_joiner (basic-big-joiner)
[524.822573] Starting subtest: basic-big-joiner
[524.826713] Subtest basic-big-joiner: SKIP (0.000s)
[524.890838] [102/133] (498s left) syncobj_basic (test-valid-cycle)
[524.944628] Starting subtest: test-valid-cycle
[524.946747] Subtest test-valid-cycle: SUCCESS (0.000s)
[525.045511] [103/133] (498s left) kms_force_connector_basic (force-edid)
[525.096087] Subtest force-edid: SKIP (0.000s)
[525.160477] [104/133] (498s left) kms_ccs (crc-primary-basic-y-tiled-gen12-rc-ccs)
[525.226078] Starting subtest: crc-primary-basic-y-tiled-gen12-rc-ccs
[525.228296] Starting dynamic subtest: pipe-A-eDP-1
[525.246789] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[525.256800] Starting dynamic subtest: pipe-B-eDP-1
[525.274145] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[525.282178] Starting dynamic subtest: pipe-C-eDP-1
[525.299803] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[525.307631] Starting dynamic subtest: pipe-D-eDP-1
[525.326326] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[525.329824] Subtest crc-primary-basic-y-tiled-gen12-rc-ccs: SKIP (0.006s)
[527.383946] [105/133] (495s left) kms_ccs (missing-ccs-buffer-4-tiled-mtl-rc-ccs)
[527.461233] Starting subtest: missing-ccs-buffer-4-tiled-mtl-rc-ccs
[527.463459] Starting dynamic subtest: pipe-A-eDP-1
[527.483713] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s)
[527.494692] Starting dynamic subtest: pipe-B-eDP-1
[527.514074] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[527.523249] Starting dynamic subtest: pipe-C-eDP-1
[527.542853] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[527.551068] Starting dynamic subtest: pipe-D-eDP-1
[527.570196] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[527.572336] Subtest missing-ccs-buffer-4-tiled-mtl-rc-ccs: SUCCESS (0.005s)
[529.667945] [106/133] (493s left) kms_cursor_crc (cursor-offscreen-64x64)
[529.832046] Starting subtest: cursor-offscreen-64x64
[529.834396] Starting dynamic subtest: pipe-A-eDP-1
[531.779129] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.945s)
[531.814264] Starting dynamic subtest: pipe-D-eDP-1
[534.369100] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.568s)
[534.371375] Subtest cursor-offscreen-64x64: SUCCESS (4.538s)
[535.216909] [107/133] (488s left) kms_big_fb (y-tiled-16bpp-rotate-180)
[535.306969] Starting subtest: y-tiled-16bpp-rotate-180
[535.311294] Subtest y-tiled-16bpp-rotate-180: SKIP (0.000s)
[535.408146] [108/133] (488s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-blt)
[535.499728] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-blt
[535.504159] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-blt: SKIP (0.000s)
[535.598397] [109/133] (487s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-mmap-cpu)
[535.680420] Starting subtest: fbc-rgb101010-draw-mmap-cpu
[540.234488] Subtest fbc-rgb101010-draw-mmap-cpu: SUCCESS (4.557s)
[541.344533] [110/133] (482s left) perf (short-reads)
[541.445130] Starting subtest: short-reads
[541.463901] Subtest short-reads: SUCCESS (0.019s)
[541.538876] [111/133] (482s left) kms_cursor_crc (cursor-tearing-framebuffer-change)
[541.636756] Starting subtest: cursor-tearing-framebuffer-change
[541.638628] Starting dynamic subtest: pipe-A-eDP-1
[542.200432] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.564s)
[542.209593] Starting dynamic subtest: pipe-D-eDP-1
[543.460438] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.258s)
[543.462904] Subtest cursor-tearing-framebuffer-change: SUCCESS (1.824s)
[544.295183] [112/133] (479s left) gem_exec_reloc (basic-wc-gtt-active)
[544.357631] Subtest basic-wc-gtt-active: SKIP (0.000s)
[544.433209] [113/133] (479s left) gem_render_copy (yf-tiled-mc-ccs-to-vebox-yf-tiled)
[544.485198] Starting subtest: yf-tiled-mc-ccs-to-vebox-yf-tiled
[544.489936] Subtest yf-tiled-mc-ccs-to-vebox-yf-tiled: SKIP (0.000s)
[544.672737] [114/133] (479s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-180)
[544.758445] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-180
[545.737895] Subtest x-tiled-max-hw-stride-32bpp-rotate-180: SUCCESS (0.979s)
[545.859163] [115/133] (477s left) kms_plane_alpha_blend (constant-alpha-max)
[545.933386] Starting subtest: constant-alpha-max
[546.211404] Starting dynamic subtest: pipe-A-eDP-1
[547.178750] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.964s)
[547.187682] Starting dynamic subtest: pipe-D-eDP-1
[548.825841] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.646s)
[548.828134] Subtest constant-alpha-max: SUCCESS (2.893s)
[549.665610] [116/133] (474s left) kms_psr (fbc-psr2-cursor-render)
[549.758981] Starting subtest: fbc-psr2-cursor-render
[549.761340] Starting dynamic subtest: eDP-1
[549.765670] Dynamic subtest eDP-1: SKIP (0.000s)
[549.770075] Subtest fbc-psr2-cursor-render: SKIP (0.001s)
[549.836902] [117/133] (473s left) kms_chamelium_edid (dp-edid-resolution-list)
[550.209277] Subtest dp-edid-resolution-list: SKIP (0.000s)
[550.971798] [118/133] (472s left) gem_eio (wait-wedge-1us)
[551.212735] Starting subtest: wait-wedge-1us
[552.930504] Subtest wait-wedge-1us: SUCCESS (1.717s)
[553.063876] [119/133] (470s left) kms_cursor_legacy (flip-vs-cursor-busy-crc-atomic)
[553.165781] Starting subtest: flip-vs-cursor-busy-crc-atomic
[553.991247] Subtest flip-vs-cursor-busy-crc-atomic: SUCCESS (0.823s)
[554.837882] [120/133] (469s left) gem_ctx_shared (q-promotion)
[554.912399] Starting subtest: Q-promotion
[554.914701] Starting dynamic subtest: rcs0
[555.037750] Dynamic subtest rcs0: SUCCESS (0.124s)
[555.049053] Starting dynamic subtest: vcs0
[555.136463] Dynamic subtest vcs0: SUCCESS (0.098s)
[555.151840] Starting dynamic subtest: vcs1
[555.222022] Dynamic subtest vcs1: SUCCESS (0.085s)
[555.236664] Starting dynamic subtest: vecs0
[555.305308] Dynamic subtest vecs0: SUCCESS (0.082s)
[555.321944] Starting dynamic subtest: ccs0
[555.399543] Dynamic subtest ccs0: SUCCESS (0.093s)
[555.402067] Subtest Q-promotion: SUCCESS (0.487s)
[556.913198] [121/133] (467s left) kms_pm_lpsp (kms-lpsp)
[558.014095] Starting subtest: kms-lpsp
[558.016387] Starting dynamic subtest: pipe-A-eDP-1
[558.161690] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.150s)
[558.457999] Subtest kms-lpsp: SUCCESS (0.446s)
[559.251498] [122/133] (464s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-blt)
[559.333541] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-blt
[566.069084] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-blt: SUCCESS (6.738s)
[566.170722] [123/133] (457s left) gem_exec_fence (basic-wait)
[566.342224] Starting subtest: basic-wait
[566.344707] Starting dynamic subtest: rcs0
[566.426220] Dynamic subtest rcs0: SUCCESS (0.084s)
[566.440357] Starting dynamic subtest: bcs0
[566.496508] Dynamic subtest bcs0: SUCCESS (0.067s)
[566.510393] Starting dynamic subtest: vcs0
[566.556190] Dynamic subtest vcs0: SUCCESS (0.057s)
[566.569149] Starting dynamic subtest: vcs1
[566.621692] Dynamic subtest vcs1: SUCCESS (0.063s)
[566.633150] Starting dynamic subtest: vecs0
[566.674810] Dynamic subtest vecs0: SUCCESS (0.051s)
[566.685883] Starting dynamic subtest: ccs0
[566.731706] Dynamic subtest ccs0: SUCCESS (0.054s)
[566.734209] Subtest basic-wait: SUCCESS (0.391s)
[568.929933] [124/133] (455s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-blt)
[569.018141] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-blt
[569.022399] Subtest psr-2p-scndscrn-pri-indfb-draw-blt: SKIP (0.000s)
[569.102772] [125/133] (455s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-indfb-plflip-blt)
[569.178482] Starting subtest: fbc-2p-scndscrn-indfb-plflip-blt
[569.182754] Subtest fbc-2p-scndscrn-indfb-plflip-blt: SKIP (0.000s)
[569.274416] [126/133] (454s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-mmap-gtt)
[569.357317] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-mmap-gtt
[569.361429] Subtest fbc-1p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[569.470283] [127/133] (454s left) gem_workarounds (suspend-resume)
[569.533447] Starting subtest: suspend-resume
[586.333179] Subtest suspend-resume: SUCCESS (1.311s)
[586.485560] [128/133] (437s left) gem_ctx_isolation (preservation-s3)
[586.568428] Starting subtest: preservation-S3
[586.570635] Starting dynamic subtest: rcs0
[602.340803] Dynamic subtest rcs0: SUCCESS (1.338s)
[602.352733] Starting dynamic subtest: bcs0
[618.333982] Dynamic subtest bcs0: SUCCESS (1.369s)
[618.343656] Starting dynamic subtest: vcs0
[634.362853] Dynamic subtest vcs0: SUCCESS (3.305s)
[634.374806] Starting dynamic subtest: vcs1
[652.352920] Dynamic subtest vcs1: SUCCESS (5.076s)
[652.368515] Starting dynamic subtest: vecs0
[670.338483] Dynamic subtest vecs0: SUCCESS (5.088s)
[670.349540] Starting dynamic subtest: ccs0
[688.339029] Dynamic subtest ccs0: SUCCESS (3.316s)
[688.341237] Subtest preservation-S3: SUCCESS (19.498s)
[688.569434] [129/133] (335s left) kms_flip (nonexisting-fb-interruptible)
[688.648409] Starting subtest: nonexisting-fb-interruptible
[688.650739] Starting dynamic subtest: A-eDP1
[689.830960] Dynamic subtest A-eDP1: SUCCESS (1.215s)
[689.842666] Starting dynamic subtest: B-eDP1
[690.926282] Dynamic subtest B-eDP1: SUCCESS (1.122s)
[690.937981] Starting dynamic subtest: C-eDP1
[692.033039] Dynamic subtest C-eDP1: SUCCESS (1.129s)
[692.047047] Starting dynamic subtest: D-eDP1
[693.142605] Dynamic subtest D-eDP1: SUCCESS (1.129s)
[693.147263] Subtest nonexisting-fb-interruptible: SUCCESS (4.605s)
[694.311720] [130/133] (330s left) gem_mmap_offset (close-race)
[694.360460] Starting subtest: close-race
[714.474829] Subtest close-race: SUCCESS (20.224s)
[714.578284] [131/133] (309s left) gem_exec_fence (syncobj-timeline-wait)
[715.154750] Starting subtest: syncobj-timeline-wait
[716.133829] Subtest syncobj-timeline-wait: SUCCESS (0.980s)
[718.162488] [132/133] (306s left) kms_big_fb (x-tiled-addfb)
[718.247038] Starting subtest: x-tiled-addfb
[718.249228] Subtest x-tiled-addfb: SUCCESS (0.000s)
[718.353660] [133/133] (306s left) kms_addfb_basic (unused-offsets)
[718.408051] Starting subtest: unused-offsets
[718.410304] Subtest unused-offsets: SUCCESS (0.000s)
[718.515164] Closing watchdogs
results: parsing output: 0/ for test: kms_feature_discovery
results: parsing output: 1/ for test: perf
results: parsing output: 2/ for test: kms_content_protection
results: parsing output: 3/ for test: kms_flip
results: parsing output: 4/ for test: gem_ctx_persistence
results: parsing output: 5/ for test: kms_frontbuffer_tracking
results: parsing output: 6/ for test: gem_pxp
results: parsing output: 7/ for test: gem_softpin
results: parsing output: 8/ for test: gem_ccs
results: parsing output: 9/ for test: sysfs_timeslice_duration
results: parsing output: 10/ for test: kms_psr
results: parsing output: 11/ for test: kms_busy
results: parsing output: 12/ for test: gem_exec_fence
results: parsing output: 13/ for test: kms_big_fb
results: parsing output: 14/ for test: kms_frontbuffer_tracking
results: parsing output: 15/ for test: gem_exec_reloc
results: parsing output: 16/ for test: syncobj_timeline
results: parsing output: 17/ for test: kms_cursor_legacy
results: parsing output: 18/ for test: kms_chamelium_hpd
results: parsing output: 19/ for test: gem_workarounds
results: parsing output: 20/ for test: perf
results: parsing output: 21/ for test: kms_plane_scaling
results: parsing output: 22/ for test: kms_frontbuffer_tracking
results: parsing output: 23/ for test: syncobj_timeline
results: parsing output: 24/ for test: syncobj_wait
results: parsing output: 25/ for test: syncobj_timeline
results: parsing output: 26/ for test: kms_color_pipeline
results: parsing output: 27/ for test: kms_frontbuffer_tracking
results: parsing output: 28/ for test: gem_mmap
results: parsing output: 29/ for test: syncobj_eventfd
results: parsing output: 30/ for test: kms_lease
results: parsing output: 31/ for test: i915_pm_rpm
results: parsing output: 32/ for test: kms_cursor_crc
results: parsing output: 33/ for test: kms_plane_scaling
results: parsing output: 34/ for test: kms_vrr
results: parsing output: 35/ for test: gem_userptr_blits
results: parsing output: 36/ for test: syncobj_timeline
results: parsing output: 37/ for test: kms_frontbuffer_tracking
results: parsing output: 38/ for test: gen9_exec_parse
results: parsing output: 39/ for test: kms_psr
results: parsing output: 40/ for test: core_setmaster
results: parsing output: 41/ for test: kms_psr2_sf
results: parsing output: 42/ for test: gem_mmap_gtt
results: parsing output: 43/ for test: kms_vrr
results: parsing output: 44/ for test: kms_cursor_legacy
results: parsing output: 45/ for test: kms_flip
results: parsing output: 46/ for test: kms_plane
results: parsing output: 47/ for test: i915_module_load
results: parsing output: 48/ for test: i915_pm_rps
results: parsing output: 49/ for test: kms_psr_stress_test
results: parsing output: 50/ for test: kms_big_fb
results: parsing output: 51/ for test: gem_gpgpu_fill
results: parsing output: 52/ for test: kms_sequence
results: parsing output: 53/ for test: kms_frontbuffer_tracking
results: parsing output: 54/ for test: syncobj_wait
results: parsing output: 55/ for test: kms_frontbuffer_tracking
results: parsing output: 56/ for test: gem_mmap_wc
results: parsing output: 57/ for test: prime_vgem
results: parsing output: 58/ for test: api_intel_bb
results: parsing output: 59/ for test: vgem_basic
results: parsing output: 60/ for test: perf
results: parsing output: 61/ for test: kms_ccs
results: parsing output: 62/ for test: kms_big_fb
results: parsing output: 63/ for test: kms_flip
results: parsing output: 64/ for test: kms_frontbuffer_tracking
results: parsing output: 65/ for test: gem_exec_whisper
results: parsing output: 66/ for test: kms_chamelium_audio
results: parsing output: 67/ for test: kms_flip_scaled_crc
results: parsing output: 68/ for test: kms_plane_cursor
results: parsing output: 69/ for test: gen9_exec_parse
results: parsing output: 70/ for test: gem_mmap_gtt
results: parsing output: 71/ for test: gem_workarounds
results: parsing output: 72/ for test: kms_atomic_transition
results: parsing output: 73/ for test: kms_fbcon_fbt
results: parsing output: 74/ for test: kms_psr
results: parsing output: 75/ for test: kms_psr
results: parsing output: 76/ for test: gem_exec_balancer
results: parsing output: 77/ for test: gem_exec_schedule
results: parsing output: 78/ for test: kms_rotation_crc
results: parsing output: 79/ for test: kms_feature_discovery
results: parsing output: 80/ for test: gem_softpin
results: parsing output: 81/ for test: kms_big_fb
results: parsing output: 82/ for test: perf_pmu
results: parsing output: 83/ for test: kms_frontbuffer_tracking
results: parsing output: 84/ for test: kms_frontbuffer_tracking
results: parsing output: 85/ for test: kms_flip
results: parsing output: 86/ for test: kms_addfb_basic
results: parsing output: 87/ for test: api_intel_bb
results: parsing output: 88/ for test: gem_sync
results: parsing output: 89/ for test: kms_psr2_sf
results: parsing output: 90/ for test: gem_exec_schedule
results: parsing output: 91/ for test: gem_busy
results: parsing output: 92/ for test: kms_pm_rpm
results: parsing output: 93/ for test: kms_flip_scaled_crc
results: parsing output: 94/ for test: kms_rotation_crc
results: parsing output: 95/ for test: kms_hdr
results: parsing output: 96/ for test: gem_mmap_wc
results: parsing output: 97/ for test: kms_ccs
results: parsing output: 98/ for test: prime_mmap
results: parsing output: 99/ for test: kms_cursor_legacy
results: parsing output: 100/ for test: kms_joiner
results: parsing output: 101/ for test: syncobj_basic
results: parsing output: 102/ for test: kms_force_connector_basic
results: parsing output: 103/ for test: kms_ccs
results: parsing output: 104/ for test: kms_ccs
results: parsing output: 105/ for test: kms_cursor_crc
results: parsing output: 106/ for test: kms_big_fb
results: parsing output: 107/ for test: kms_frontbuffer_tracking
results: parsing output: 108/ for test: kms_frontbuffer_tracking
results: parsing output: 109/ for test: perf
results: parsing output: 110/ for test: kms_cursor_crc
results: parsing output: 111/ for test: gem_exec_reloc
results: parsing output: 112/ for test: gem_render_copy
results: parsing output: 113/ for test: kms_big_fb
results: parsing output: 114/ for test: kms_plane_alpha_blend
results: parsing output: 115/ for test: kms_psr
results: parsing output: 116/ for test: kms_chamelium_edid
results: parsing output: 117/ for test: gem_eio
results: parsing output: 118/ for test: kms_cursor_legacy
results: parsing output: 119/ for test: gem_ctx_shared
results: parsing output: 120/ for test: kms_pm_lpsp
results: parsing output: 121/ for test: kms_frontbuffer_tracking
results: parsing output: 122/ for test: gem_exec_fence
results: parsing output: 123/ for test: kms_frontbuffer_tracking
results: parsing output: 124/ for test: kms_frontbuffer_tracking
results: parsing output: 125/ for test: kms_frontbuffer_tracking
results: parsing output: 126/ for test: gem_workarounds
results: parsing output: 127/ for test: gem_ctx_isolation
results: parsing output: 128/ for test: kms_flip
results: parsing output: 129/ for test: gem_mmap_offset
results: parsing output: 130/ for test: gem_exec_fence
results: parsing output: 131/ for test: kms_big_fb
results: parsing output: 132/ for test: kms_addfb_basic
Done.