[61.228353] Initializing watchdogs
[61.228400]   /dev/watchdog0
[61.243385] [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]
[61.248672] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[61.251076] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[61.253089] [001/133] (960s left) kms_cursor_legacy (modeset-atomic-cursor-hotspot)
[61.369384] Starting subtest: modeset-atomic-cursor-hotspot
[61.371345] Subtest modeset-atomic-cursor-hotspot: SKIP (0.000s)
[61.520433] [002/133] (960s left) kms_big_fb (4-tiled-addfb)
[61.610254] Starting subtest: 4-tiled-addfb
[61.611371] Subtest 4-tiled-addfb: SUCCESS (0.000s)
[61.704272] [003/133] (960s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-onoff)
[61.800895] Starting subtest: fbc-2p-scndscrn-cur-indfb-onoff
[61.802601] Subtest fbc-2p-scndscrn-cur-indfb-onoff: SKIP (0.000s)
[61.882813] [004/133] (959s left) kms_plane_scaling (plane-upscale-20x20-with-modifiers)
[61.968937] Starting subtest: plane-upscale-20x20-with-modifiers
[61.969949] Starting dynamic subtest: pipe-A
[62.318591] Dynamic subtest pipe-A: SUCCESS (0.349s)
[62.325405] Starting dynamic subtest: pipe-B
[63.703898] Dynamic subtest pipe-B: SUCCESS (1.383s)
[63.710885] Starting dynamic subtest: pipe-C
[65.129963] Dynamic subtest pipe-C: SUCCESS (1.424s)
[65.137053] Starting dynamic subtest: pipe-D
[66.560386] Dynamic subtest pipe-D: SUCCESS (1.429s)
[66.561405] Subtest plane-upscale-20x20-with-modifiers: SUCCESS (4.587s)
[67.739864] [005/133] (954s left) kms_properties (invalid-properties-legacy)
[67.852273] Starting subtest: invalid-properties-legacy
[67.972641] Subtest invalid-properties-legacy: SUCCESS (0.111s)
[68.025505] [006/133] (953s left) syncobj_timeline (multi-wait-for-submit-unsubmitted-submitted-signaled)
[68.097457] Starting subtest: multi-wait-for-submit-unsubmitted-submitted-signaled
[68.098425] Subtest multi-wait-for-submit-unsubmitted-submitted-signaled: SUCCESS (0.001s)
[68.186643] [007/133] (953s left) gem_tiling_max_stride
[68.287700] [008/133] (953s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-mmap-gtt)
[68.369873] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-mmap-gtt
[68.371858] Subtest fbc-2p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[68.457215] [009/133] (953s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-gtt)
[68.557691] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-gtt
[68.559377] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[68.648419] [010/133] (953s left) kms_ccs (random-ccs-data-y-tiled-gen12-rc-ccs)
[68.727194] Starting subtest: random-ccs-data-y-tiled-gen12-rc-ccs
[68.728179] Starting dynamic subtest: pipe-A-eDP-1
[68.738371] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[68.744993] Starting dynamic subtest: pipe-B-eDP-1
[68.754587] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[68.767676] Starting dynamic subtest: pipe-C-eDP-1
[68.776535] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[68.781658] Starting dynamic subtest: pipe-D-eDP-1
[68.790516] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[68.792025] Subtest random-ccs-data-y-tiled-gen12-rc-ccs: SKIP (0.003s)
[70.991847] [011/133] (951s left) syncobj_basic (bad-pad-handle-to-fd)
[71.045048] Starting subtest: bad-pad-handle-to-fd
[71.046064] Subtest bad-pad-handle-to-fd: SUCCESS (0.000s)
[71.126167] [012/133] (950s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-0-hflip)
[71.214333] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-0-hflip
[71.216219] Subtest y-tiled-max-hw-stride-64bpp-rotate-0-hflip: SKIP (0.000s)
[71.289730] [013/133] (950s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-mmap-cpu)
[71.378783] Starting subtest: fbcpsr-rgb565-draw-mmap-cpu
[78.300176] Subtest fbcpsr-rgb565-draw-mmap-cpu: SUCCESS (6.920s)
[78.403031] [014/133] (943s left) gen9_exec_parse (bb-start-far)
[78.470562] Subtest bb-start-far: SKIP (0.000s)
[78.532169] [015/133] (943s left) kms_scaling_modes (scaling-mode-full)
[78.614042] Starting subtest: scaling-mode-full
[78.615127] Starting dynamic subtest: pipe-A-eDP-1
[78.711759] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.097s)
[78.718858] Starting dynamic subtest: pipe-B-eDP-1
[79.860729] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.148s)
[79.867863] Starting dynamic subtest: pipe-C-eDP-1
[80.979732] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.118s)
[80.988063] Starting dynamic subtest: pipe-D-eDP-1
[82.110448] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.129s)
[82.111338] Subtest scaling-mode-full: SUCCESS (3.496s)
[83.267635] [016/133] (938s left) api_intel_bb (purge-bb)
[83.321174] Starting subtest: purge-bb
[83.323727] Subtest purge-bb: SUCCESS (0.003s)
[83.425544] [017/133] (938s left) gem_exec_fence (long-history)
[83.860299] Starting subtest: long-history
[90.676570] Subtest long-history: SUCCESS (6.807s)
[91.153806] [FACT gem_exec_fence (long-history)] new: kernel.kmod_is_loaded.vgem: true
[91.155397] [018/133] (931s left) gem_media_fill (media-fill)
[91.203335] Subtest media-fill: SKIP (0.000s)
[91.304688] [019/133] (931s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-gtt)
[91.399637] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-gtt
[91.401332] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[91.505121] [020/133] (930s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-64bpp-ytile-downscaling)
[91.594066] Starting subtest: flip-32bpp-ytile-to-64bpp-ytile-downscaling
[91.595822] Subtest flip-32bpp-ytile-to-64bpp-ytile-downscaling: SKIP (0.000s)
[91.658218] [021/133] (930s left) kms_lease (lease-again)
[91.745437] Starting subtest: lease-again
[91.746462] Starting dynamic subtest: pipe-A-eDP-1
[91.749052] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.002s)
[91.757378] Starting dynamic subtest: pipe-B-eDP-1
[91.758445] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.002s)
[91.764284] Starting dynamic subtest: pipe-C-eDP-1
[91.765223] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.002s)
[91.771207] Starting dynamic subtest: pipe-D-eDP-1
[91.772060] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[91.772871] Subtest lease-again: SUCCESS (0.011s)
[91.852424] [022/133] (930s left) kms_hdr (static-swap)
[91.936199] Starting subtest: static-swap
[91.938838] Subtest static-swap: SKIP (0.000s)
[92.002151] [023/133] (930s left) kms_psr (psr2-primary-render)
[92.090187] Starting subtest: psr2-primary-render
[92.091174] Starting dynamic subtest: eDP-1
[93.872446] Dynamic subtest eDP-1: SUCCESS (1.781s)
[93.873297] Subtest psr2-primary-render: SUCCESS (1.781s)
[94.730784] [024/133] (927s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-0-async-flip)
[94.837837] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-0-async-flip
[94.839781] Subtest y-tiled-max-hw-stride-32bpp-rotate-0-async-flip: SKIP (0.000s)
[94.925215] [025/133] (927s left) i915_hangman (engine-engine-hang)
[94.974425] Starting subtest: engine-engine-hang
[94.975415] Starting dynamic subtest: rcs0
[96.895345] Dynamic subtest rcs0: SUCCESS (1.912s)
[96.902617] Starting dynamic subtest: bcs0
[98.877842] Dynamic subtest bcs0: SUCCESS (1.981s)
[98.886912] Starting dynamic subtest: vcs0
[100.862612] Dynamic subtest vcs0: SUCCESS (1.983s)
[100.871877] Starting dynamic subtest: vcs1
[102.911628] Dynamic subtest vcs1: SUCCESS (2.047s)
[102.920394] Starting dynamic subtest: vecs0
[104.894813] Dynamic subtest vecs0: SUCCESS (1.982s)
[104.910550] Starting dynamic subtest: ccs0
[106.878764] Dynamic subtest ccs0: SUCCESS (1.982s)
[106.880031] Subtest engine-engine-hang: SUCCESS (11.896s)
[106.989206] [026/133] (915s left) i915_pm_rps (thresholds-idle-park)
[107.053099] Starting subtest: thresholds-idle-park
[107.054964] Subtest thresholds-idle-park: SKIP (0.001s)
[107.192384] [027/133] (915s left) kms_big_fb (x-tiled-16bpp-rotate-180)
[107.292337] Starting subtest: x-tiled-16bpp-rotate-180
[108.593435] Subtest x-tiled-16bpp-rotate-180: SUCCESS (1.302s)
[108.699794] [028/133] (913s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-render)
[108.783582] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-render
[108.785320] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-render: SKIP (0.000s)
[108.871397] [029/133] (913s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-render)
[108.963578] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-render
[116.274975] Subtest psr-1p-primscrn-pri-shrfb-draw-render: SUCCESS (7.312s)
[116.380344] [030/133] (906s left) api_intel_bb (blit-noreloc-keep-cache)
[116.431750] Starting subtest: blit-noreloc-keep-cache
[116.440794] Subtest blit-noreloc-keep-cache: SUCCESS (0.010s)
[116.560678] [031/133] (906s left) kms_plane (pixel-format-4-tiled-bmg-ccs-modifier)
[116.663489] Starting subtest: pixel-format-4-tiled-bmg-ccs-modifier
[116.665537] Subtest pixel-format-4-tiled-bmg-ccs-modifier: SKIP (0.000s)
[116.742352] [032/133] (906s left) kms_flip (2x-wf_vblank-ts-check-interruptible)
[116.831048] Starting subtest: 2x-wf_vblank-ts-check-interruptible
[116.841552] Subtest 2x-wf_vblank-ts-check-interruptible: SKIP (0.011s)
[116.911716] [033/133] (905s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-indfb-draw-mmap-wc)
[117.005655] Starting subtest: psr-1p-offscreen-pri-indfb-draw-mmap-wc
[123.688795] Subtest psr-1p-offscreen-pri-indfb-draw-mmap-wc: SUCCESS (6.682s)
[123.823768] [034/133] (899s left) kms_cursor_legacy (cursorb-vs-flipa-atomic)
[123.934307] Starting subtest: cursorB-vs-flipA-atomic
[123.937347] Subtest cursorB-vs-flipA-atomic: SKIP (0.001s)
[124.087073] [035/133] (898s left) gem_ringfill (engines-basic)
[129.890772] Starting subtest: engines-basic
[129.892132] Starting dynamic subtest: rcs0
[129.952059] Dynamic subtest rcs0: SUCCESS (0.067s)
[129.961558] Starting dynamic subtest: bcs0
[129.996978] Dynamic subtest bcs0: SUCCESS (0.044s)
[130.010537] Starting dynamic subtest: vcs0
[130.044064] Dynamic subtest vcs0: SUCCESS (0.046s)
[130.053819] Starting dynamic subtest: vcs1
[130.086699] Dynamic subtest vcs1: SUCCESS (0.041s)
[130.094132] Starting dynamic subtest: vecs0
[130.129401] Dynamic subtest vecs0: SUCCESS (0.042s)
[130.141487] Starting dynamic subtest: ccs0
[130.176313] Dynamic subtest ccs0: SUCCESS (0.046s)
[130.177779] Subtest engines-basic: SUCCESS (0.293s)
[130.259315] [036/133] (892s left) kms_big_fb (yf-tiled-8bpp-rotate-270)
[130.363870] Starting subtest: yf-tiled-8bpp-rotate-270
[130.365423] Subtest yf-tiled-8bpp-rotate-270: SKIP (0.000s)
[130.466868] [037/133] (892s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-180-hflip)
[130.569215] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-180-hflip
[131.573409] Subtest 4-tiled-max-hw-stride-64bpp-rotate-180-hflip: SUCCESS (1.004s)
[131.691806] [038/133] (891s left) gem_mmap_gtt (hang)
[131.747822] Subtest hang: SKIP (0.000s)
[131.810026] [039/133] (891s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-mmap-cpu)
[131.905796] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-mmap-cpu
[135.478561] Subtest fbc-1p-primscrn-cur-indfb-draw-mmap-cpu: SUCCESS (3.573s)
[136.601744] [040/133] (886s left) kms_addfb_basic (addfb25-x-tiled-legacy)
[136.695926] Subtest addfb25-x-tiled-legacy: SKIP (0.000s)
[136.778655] [041/133] (886s left) sriov_basic (enable-vfs-bind-unbind-each)
[136.832815] Starting subtest: enable-vfs-bind-unbind-each
[136.833822] Starting dynamic subtest: numvfs-1
[136.866521] Dynamic subtest numvfs-1: FAIL (0.016s)
[136.873739] Starting dynamic subtest: numvfs-2
[136.900531] Dynamic subtest numvfs-2: FAIL (0.004s)
[136.906701] Starting dynamic subtest: numvfs-3
[136.936017] Dynamic subtest numvfs-3: FAIL (0.004s)
[136.942528] Starting dynamic subtest: numvfs-4
[136.968441] Dynamic subtest numvfs-4: FAIL (0.004s)
[136.974529] Starting dynamic subtest: numvfs-5
[137.000184] Dynamic subtest numvfs-5: FAIL (0.004s)
[137.009074] Starting dynamic subtest: numvfs-6
[137.036648] Dynamic subtest numvfs-6: FAIL (0.004s)
[137.042776] Starting dynamic subtest: numvfs-7
[137.068841] Dynamic subtest numvfs-7: FAIL (0.004s)
[137.074387] Starting dynamic subtest: numvfs-random
[137.099484] Dynamic subtest numvfs-random: FAIL (0.004s)
[137.100330] Subtest enable-vfs-bind-unbind-each: FAIL (0.045s)
[137.148934] [042/133] (885s left) syncobj_wait (wait-for-submit-complex)
[137.192284] Starting subtest: wait-for-submit-complex
[137.254413] Subtest wait-for-submit-complex: SUCCESS (0.062s)
[137.328847] [043/133] (885s left) kms_rotation_crc (sprite-rotation-90)
[137.408618] Starting subtest: sprite-rotation-90
[137.410421] Subtest sprite-rotation-90: SKIP (0.001s)
[137.476892] [044/133] (885s left) gem_exec_reloc (basic-write-wc)
[137.536484] Subtest basic-write-wc: SKIP (0.000s)
[137.606059] [045/133] (885s left) gem_exercise_blt (fast-copy-emit)
[137.661275] Starting subtest: fast-copy-emit
[137.662097] Starting dynamic subtest: linear-smem-smem-emit
[137.684535] Dynamic subtest linear-smem-smem-emit: SUCCESS (0.023s)
[137.692168] Starting dynamic subtest: xmajor-smem-smem-emit
[137.702449] Dynamic subtest xmajor-smem-smem-emit: SUCCESS (0.018s)
[137.716695] Starting dynamic subtest: tile4-smem-smem-emit
[137.720192] Dynamic subtest tile4-smem-smem-emit: SUCCESS (0.017s)
[137.726913] Starting dynamic subtest: tile64-smem-smem-emit
[137.737456] Dynamic subtest tile64-smem-smem-emit: SUCCESS (0.017s)
[137.738358] Subtest fast-copy-emit: SUCCESS (0.076s)
[137.861177] [046/133] (885s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-pwrite)
[137.953360] Starting subtest: psr-2p-primscrn-spr-indfb-draw-pwrite
[137.955151] Subtest psr-2p-primscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[138.038192] [047/133] (885s left) kms_cursor_crc (cursor-onscreen-32x10)
[138.196232] Starting subtest: cursor-onscreen-32x10
[138.252761] Subtest cursor-onscreen-32x10: SKIP (0.054s)
[138.548580] [048/133] (884s left) kms_cursor_legacy (cursor-vs-flip-legacy)
[138.671310] Starting subtest: cursor-vs-flip-legacy
[168.121837] Subtest cursor-vs-flip-legacy: SUCCESS (29.450s)
[168.922658] [049/133] (854s left) kms_atomic (test-only)
[169.012448] Starting subtest: test-only
[169.059970] Starting dynamic subtest: pipe-A-eDP-1
[171.541036] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.481s)
[171.541894] Subtest test-only: SUCCESS (2.530s)
[172.343018] [050/133] (851s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-indfb-plflip-blt)
[172.436651] Starting subtest: fbc-2p-scndscrn-indfb-plflip-blt
[172.438429] Subtest fbc-2p-scndscrn-indfb-plflip-blt: SKIP (0.000s)
[172.536233] [051/133] (850s left) gem_ctx_shared (exec-shared-gtt)
[172.588792] Starting subtest: exec-shared-gtt
[172.589774] Starting dynamic subtest: rcs0
[172.595933] Dynamic subtest rcs0: SUCCESS (0.007s)
[172.603242] Starting dynamic subtest: bcs0
[172.604108] Dynamic subtest bcs0: SUCCESS (0.006s)
[172.610896] Starting dynamic subtest: vcs0
[172.612092] Dynamic subtest vcs0: SUCCESS (0.007s)
[172.618101] Starting dynamic subtest: vcs1
[172.618900] Dynamic subtest vcs1: SUCCESS (0.006s)
[172.624865] Starting dynamic subtest: vecs0
[172.625737] Dynamic subtest vecs0: SUCCESS (0.006s)
[172.632051] Starting dynamic subtest: ccs0
[172.632899] Dynamic subtest ccs0: SUCCESS (0.005s)
[172.633764] Subtest exec-shared-gtt: SUCCESS (0.040s)
[172.805934] [052/133] (850s left) gem_exec_reloc (basic-cpu-gtt)
[172.877037] Subtest basic-cpu-gtt: SKIP (0.000s)
[172.936709] [053/133] (850s left) gem_mmap_wc (write)
[172.999590] Subtest write: SKIP (0.000s)
[173.077157] [054/133] (850s left) kms_sequence (get-forked)
[173.164117] Starting subtest: get-forked
[173.165078] Starting dynamic subtest: pipe-A-eDP-1
[175.044193] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.878s)
[175.051485] Starting dynamic subtest: pipe-B-eDP-1
[177.613522] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.562s)
[177.620646] Starting dynamic subtest: pipe-C-eDP-1
[180.094815] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.487s)
[180.101358] Starting dynamic subtest: pipe-D-eDP-1
[182.619751] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.524s)
[182.620683] Subtest get-forked: SUCCESS (9.455s)
[183.471881] [055/133] (840s left) kms_flip_scaled_crc (flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling)
[183.569435] Starting subtest: flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling
[183.571198] Subtest flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling: SKIP (0.000s)
[183.650352] [056/133] (839s left) gem_exec_schedule (pi-ringfull)
[183.848592] Starting subtest: pi-ringfull
[183.849394] Starting dynamic subtest: rcs0
[183.863047] Dynamic subtest rcs0: SUCCESS (0.032s)
[183.869744] Starting dynamic subtest: bcs0
[183.894601] Dynamic subtest bcs0: SUCCESS (0.031s)
[183.901158] Starting dynamic subtest: vcs0
[183.924255] Dynamic subtest vcs0: SUCCESS (0.029s)
[183.930499] Starting dynamic subtest: vcs1
[183.950880] Dynamic subtest vcs1: SUCCESS (0.026s)
[183.957281] Starting dynamic subtest: vecs0
[183.978355] Dynamic subtest vecs0: SUCCESS (0.026s)
[183.984783] Starting dynamic subtest: ccs0
[184.005725] Dynamic subtest ccs0: SUCCESS (0.027s)
[184.006568] Subtest pi-ringfull: SUCCESS (0.175s)
[184.225903] [057/133] (839s left) kms_pm_rpm (modeset-non-lpsp-stress)
[186.045196] Starting subtest: modeset-non-lpsp-stress
[187.190592] Subtest modeset-non-lpsp-stress: SKIP (1.144s)
[187.585712] [058/133] (836s left) i915_drm_fdinfo (most-busy-check-all)
[187.629038] Starting subtest: most-busy-check-all
[187.629860] Starting dynamic subtest: rcs0
[187.633436] Dynamic subtest rcs0: SKIP (0.004s)
[187.641884] Starting dynamic subtest: bcs0
[187.643521] Dynamic subtest bcs0: SKIP (0.000s)
[187.649198] Starting dynamic subtest: vcs0
[187.650856] Dynamic subtest vcs0: SKIP (0.000s)
[187.656742] Starting dynamic subtest: vcs1
[187.658375] Dynamic subtest vcs1: SKIP (0.000s)
[187.664299] Starting dynamic subtest: vecs0
[187.666015] Dynamic subtest vecs0: SKIP (0.000s)
[187.671889] Starting dynamic subtest: ccs0
[187.673556] Dynamic subtest ccs0: SKIP (0.001s)
[187.675198] Subtest most-busy-check-all: SKIP (0.011s)
[187.708324] [059/133] (836s left) kms_color (gamma)
[187.813516] Starting subtest: gamma
[187.814456] Starting dynamic subtest: pipe-A-eDP-1
[188.525949] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.713s)
[188.532692] Starting dynamic subtest: pipe-B-eDP-1
[190.023516] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.497s)
[190.034587] Starting dynamic subtest: pipe-C-eDP-1
[191.366220] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.342s)
[191.372419] Starting dynamic subtest: pipe-D-eDP-1
[192.696608] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.330s)
[192.697474] Subtest gamma: SUCCESS (4.885s)
[193.505796] [060/133] (830s left) kms_dsc (dsc-fractional-bpp-with-bpc)
[193.587333] Starting subtest: dsc-fractional-bpp-with-bpc
[193.598812] Subtest dsc-fractional-bpp-with-bpc: SKIP (0.001s)
[193.653578] [061/133] (830s left) i915_pm_rps (min-max-config-idle)
[193.711587] Starting subtest: min-max-config-idle
[193.713430] Subtest min-max-config-idle: SKIP (0.000s)
[193.805903] [062/133] (830s left) kms_psr2_sf (pr-overlay-plane-move-continuous-sf)
[193.894462] Starting subtest: pr-overlay-plane-move-continuous-sf
[193.896260] Subtest pr-overlay-plane-move-continuous-sf: SKIP (0.000s)
[193.963406] [063/133] (829s left) kms_ccs (crc-primary-rotation-180-y-tiled-gen12-mc-ccs)
[194.056467] Starting subtest: crc-primary-rotation-180-y-tiled-gen12-mc-ccs
[194.057347] Starting dynamic subtest: pipe-A-eDP-1
[194.065694] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[194.076472] Starting dynamic subtest: pipe-B-eDP-1
[194.085945] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[194.094138] Starting dynamic subtest: pipe-C-eDP-1
[194.102068] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[194.107886] Starting dynamic subtest: pipe-D-eDP-1
[194.116407] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[194.118060] Subtest crc-primary-rotation-180-y-tiled-gen12-mc-ccs: SKIP (0.005s)
[196.383390] [064/133] (827s left) kms_atomic_interruptible (legacy-pageflip)
[196.469323] Starting subtest: legacy-pageflip
[196.470189] Starting dynamic subtest: pipe-A-eDP-1
[203.928463] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.458s)
[203.929334] Subtest legacy-pageflip: SUCCESS (7.459s)
[204.762890] [065/133] (819s left) kms_big_fb (x-tiled-addfb-size-offset-overflow)
[204.867903] Starting subtest: x-tiled-addfb-size-offset-overflow
[204.868859] Subtest x-tiled-addfb-size-offset-overflow: SUCCESS (0.000s)
[204.956770] [066/133] (819s left) gem_pxp (create-regular-context-1)
[205.062215] Starting subtest: create-regular-context-1
[205.063176] Subtest create-regular-context-1: SUCCESS (0.002s)
[205.175023] [067/133] (818s left) gem_userptr_blits (process-exit-busy)
[205.234555] Starting subtest: process-exit-busy
[205.246852] Subtest process-exit-busy: SUCCESS (0.012s)
[205.370583] [068/133] (818s left) gem_sync (basic-many-each)
[205.423583] Starting subtest: basic-many-each
[207.704434] Subtest basic-many-each: SUCCESS (2.282s)
[207.896435] [069/133] (816s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-pwrite)
[207.997419] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-pwrite
[207.999173] Subtest psr-2p-scndscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[208.095394] [070/133] (816s left) gem_pxp (hw-rejects-pxp-buffer)
[208.147344] Starting subtest: hw-rejects-pxp-buffer
[208.148947] Subtest hw-rejects-pxp-buffer: SKIP (0.000s)
[208.247121] [071/133] (815s left) prime_vgem (basic-fence-flip)
[208.316668] Starting subtest: basic-fence-flip
[208.612978] Subtest basic-fence-flip: SUCCESS (0.296s)
[208.703008] [072/133] (815s left) kms_chamelium_frames (dp-frame-dump)
[209.075365] Subtest dp-frame-dump: SKIP (0.000s)
[209.865332] [073/133] (814s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-mmap-wc)
[209.955693] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-mmap-wc
[214.030377] Subtest fbc-1p-offscreen-pri-indfb-draw-mmap-wc: SUCCESS (4.074s)
[215.189144] [074/133] (809s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-render)
[215.291502] Starting subtest: psr-1p-primscrn-pri-indfb-draw-render
[222.700738] Subtest psr-1p-primscrn-pri-indfb-draw-render: SUCCESS (7.409s)
[222.818349] [075/133] (801s left) vgem_basic (sysfs)
[222.854744] Starting subtest: sysfs
[222.855833] Subtest sysfs: SUCCESS (0.000s)
[222.908333] [076/133] (801s left) kms_psr (pr-cursor-mmap-gtt)
[222.995586] Starting subtest: pr-cursor-mmap-gtt
[222.997502] Subtest pr-cursor-mmap-gtt: SKIP (0.000s)
[223.072849] [077/133] (801s left) kms_cursor_legacy (basic-busy-flip-before-cursor-varying-size)
[223.187589] Starting subtest: basic-busy-flip-before-cursor-varying-size
[223.189570] Subtest basic-busy-flip-before-cursor-varying-size: SKIP (0.000s)
[223.344070] [078/133] (801s left) kms_ccs (bad-pixel-format-4-tiled-mtl-rc-ccs)
[223.436546] Starting subtest: bad-pixel-format-4-tiled-mtl-rc-ccs
[223.437439] Starting dynamic subtest: pipe-A-eDP-1
[223.444956] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s)
[223.451694] Starting dynamic subtest: pipe-B-eDP-1
[223.459250] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[223.465668] Starting dynamic subtest: pipe-C-eDP-1
[223.473415] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[223.479649] Starting dynamic subtest: pipe-D-eDP-1
[223.486780] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[223.487587] Subtest bad-pixel-format-4-tiled-mtl-rc-ccs: SUCCESS (0.006s)
[225.682436] [079/133] (798s left) gem_fenced_exec_thrash (no-spare-fences-busy)
[225.734980] Subtest no-spare-fences-busy: SKIP (0.000s)
[225.785287] [080/133] (798s left) template (a)
[225.835888] Starting subtest: A
[225.836759] Subtest A: SUCCESS (0.000s)
[225.913845] [081/133] (798s left) kms_ccs (crc-primary-basic-4-tiled-dg2-rc-ccs)
[226.004193] Starting subtest: crc-primary-basic-4-tiled-dg2-rc-ccs
[226.005036] Starting dynamic subtest: pipe-A-eDP-1
[226.013754] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[226.020425] Starting dynamic subtest: pipe-B-eDP-1
[226.029025] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[226.035575] Starting dynamic subtest: pipe-C-eDP-1
[226.043556] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[226.049897] Starting dynamic subtest: pipe-D-eDP-1
[226.057880] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[226.059668] Subtest crc-primary-basic-4-tiled-dg2-rc-ccs: SKIP (0.006s)
[228.254513] [082/133] (796s left) syncobj_wait (invalid-wait-bad-flags)
[228.314529] Starting subtest: invalid-wait-bad-flags
[228.315525] Subtest invalid-wait-bad-flags: SUCCESS (0.000s)
[228.406463] [083/133] (796s left) kms_vblank (wait-forked-busy-hang)
[228.485178] Starting subtest: wait-forked-busy-hang
[228.485974] Starting dynamic subtest: pipe-A-eDP-1
[255.648389] Dynamic subtest pipe-A-eDP-1: SUCCESS (27.161s)
[255.656355] Starting dynamic subtest: pipe-D-eDP-1
[270.690497] Dynamic subtest pipe-D-eDP-1: SUCCESS (15.040s)
[270.691387] Subtest wait-forked-busy-hang: SUCCESS (42.205s)
[271.520499] [084/133] (753s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-shrfb-plflip-blt)
[271.611812] Starting subtest: fbcpsr-1p-primscrn-shrfb-plflip-blt
[279.144888] Subtest fbcpsr-1p-primscrn-shrfb-plflip-blt: SUCCESS (7.534s)
[279.240535] [085/133] (745s left) syncobj_wait (reset-multiple-signaled)
[279.288457] Starting subtest: reset-multiple-signaled
[279.289312] Subtest reset-multiple-signaled: SUCCESS (0.000s)
[279.380244] [086/133] (745s left) kms_cursor_legacy (cursora-vs-flipa-atomic-transitions)
[279.484668] Starting subtest: cursorA-vs-flipA-atomic-transitions
[290.639633] Subtest cursorA-vs-flipA-atomic-transitions: SUCCESS (11.153s)
[291.474037] [087/133] (733s left) kms_flip (flip-vs-expired-vblank-interruptible)
[291.582285] Starting subtest: flip-vs-expired-vblank-interruptible
[291.584523] Starting dynamic subtest: A-eDP1
[300.313764] Dynamic subtest A-eDP1: SUCCESS (8.701s)
[300.322567] Starting dynamic subtest: B-eDP1
[308.941795] Dynamic subtest B-eDP1: SUCCESS (8.625s)
[308.949646] Starting dynamic subtest: C-eDP1
[317.571584] Dynamic subtest C-eDP1: SUCCESS (8.615s)
[317.580922] Starting dynamic subtest: D-eDP1
[326.182664] Dynamic subtest D-eDP1: SUCCESS (8.643s)
[326.186325] Subtest flip-vs-expired-vblank-interruptible: SUCCESS (34.600s)
[327.345945] [088/133] (697s left) gem_ctx_persistence (engines-queued)
[327.413481] Starting subtest: engines-queued
[327.414424] Starting dynamic subtest: rcs0
[327.493891] Dynamic subtest rcs0: SUCCESS (0.081s)
[327.504159] Starting dynamic subtest: bcs0
[327.542781] Dynamic subtest bcs0: SUCCESS (0.047s)
[327.552813] Starting dynamic subtest: vcs0
[328.895973] Dynamic subtest vcs0: SUCCESS (1.342s)
[328.904807] Starting dynamic subtest: vcs1
[330.878513] Dynamic subtest vcs1: SUCCESS (1.980s)
[330.886488] Starting dynamic subtest: vecs0
[332.862960] Dynamic subtest vecs0: SUCCESS (1.981s)
[332.870434] Starting dynamic subtest: ccs0
[333.058168] Dynamic subtest ccs0: SUCCESS (0.203s)
[333.059646] Subtest engines-queued: SUCCESS (5.646s)
[333.158858] [089/133] (691s left) gem_workarounds (suspend-resume-context)
[333.224113] Starting subtest: suspend-resume-context
[349.676386] Subtest suspend-resume-context: SUCCESS (2.512s)
[356.875003] [090/133] (674s left) gem_ctx_engines (none)
[356.953462] Starting subtest: none
[356.954503] Subtest none: SUCCESS (0.003s)
[357.135163] [091/133] (674s left) gem_exec_fence (basic-busy-all)
[357.196936] Starting subtest: basic-busy-all
[357.299501] Subtest basic-busy-all: SUCCESS (0.101s)
[358.933392] [092/133] (672s left) kms_vrr (seamless-rr-switch-vrr)
[359.031052] Starting subtest: seamless-rr-switch-vrr
[359.033950] Subtest seamless-rr-switch-vrr: SKIP (0.000s)
[359.099549] [093/133] (672s left) kms_pipe_b_c_ivb (enable-pipe-c-while-b-has-3-lanes)
[359.159660] Subtest enable-pipe-C-while-B-has-3-lanes: SKIP (0.000s)
[359.219508] [094/133] (672s left) gem_exec_reloc (basic-active)
[359.281676] Subtest basic-active: SKIP (0.000s)
[359.346030] [095/133] (672s left) kms_plane (pixel-format-y-tiled-gen12-rc-ccs-cc-modifier)
[359.440126] Starting subtest: pixel-format-y-tiled-gen12-rc-ccs-cc-modifier
[359.441926] Subtest pixel-format-y-tiled-gen12-rc-ccs-cc-modifier: SKIP (0.000s)
[359.513275] [096/133] (672s left) vgem_basic (setversion)
[359.554532] Starting subtest: setversion
[359.556224] Subtest setversion: SUCCESS (0.000s)
[359.606380] [097/133] (672s left) perf_pmu (busy-idle)
[359.641079] Starting subtest: busy-idle
[359.642197] Starting dynamic subtest: rcs0
[360.341204] Dynamic subtest rcs0: SUCCESS (0.694s)
[360.352980] Starting dynamic subtest: bcs0
[361.022393] Dynamic subtest bcs0: SUCCESS (0.675s)
[361.034708] Starting dynamic subtest: vcs0
[362.836886] Dynamic subtest vcs0: SUCCESS (1.792s)
[362.847039] Starting dynamic subtest: vcs1
[364.885034] Dynamic subtest vcs1: SUCCESS (2.036s)
[364.895244] Starting dynamic subtest: vecs0
[366.868447] Dynamic subtest vecs0: SUCCESS (1.974s)
[366.878730] Starting dynamic subtest: ccs0
[367.532999] Dynamic subtest ccs0: SUCCESS (0.670s)
[367.534438] Subtest busy-idle: SUCCESS (7.856s)
[367.648544] [098/133] (664s left) syncobj_timeline (wait-any-interrupted)
[367.704447] Starting subtest: wait-any-interrupted
[367.806731] Subtest wait-any-interrupted: SUCCESS (0.102s)
[367.894541] [099/133] (664s left) gem_watchdog (default-physical)
[367.945411] Starting subtest: default-physical
[369.727036] Subtest default-physical: SUCCESS (1.777s)
[369.818880] [100/133] (662s left) kms_getfb (getfb-addfb-different-handles)
[369.900752] Starting subtest: getfb-addfb-different-handles
[369.901729] Subtest getfb-addfb-different-handles: SUCCESS (0.000s)
[370.023563] [101/133] (662s left) gem_exec_balancer (sequential)
[370.074377] Starting subtest: sequential
[373.233185] Subtest sequential: SUCCESS (3.153s)
[373.545639] [102/133] (658s left) gem_exec_reloc (basic-gtt-cpu)
[373.603487] Subtest basic-gtt-cpu: SKIP (0.000s)
[373.672972] [103/133] (658s left) kms_mmap_write_crc (main)
[373.769116] Starting subtest: main
[373.769971] Starting dynamic subtest: pipe-A-eDP-1
[377.313385] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.538s)
[377.314298] Subtest main: SUCCESS (3.539s)
[378.170270] [104/133] (654s left) gem_exec_schedule (semaphore-user)
[378.229129] Starting subtest: semaphore-user
[378.285725] Subtest semaphore-user: SUCCESS (0.057s)
[379.901671] [105/133] (652s left) gem_userptr_blits (create-destroy-unsync)
[379.958031] Subtest create-destroy-unsync: SKIP (0.000s)
[380.065914] [106/133] (652s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-mmap-wc)
[380.150340] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-mmap-wc
[380.152185] Subtest psr-2p-scndscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[380.251443] [107/133] (652s left) kms_chamelium_hpd (vga-hpd-with-enabled-mode)
[380.621110] Subtest vga-hpd-with-enabled-mode: SKIP (0.000s)
[381.457579] [108/133] (650s left) kms_atomic_transition (plane-all-transition-nonblocking-fencing)
[381.540028] Starting subtest: plane-all-transition-nonblocking-fencing
[381.540894] Starting dynamic subtest: pipe-A-eDP-1
[384.038532] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.496s)
[384.363014] Starting dynamic subtest: pipe-B-eDP-1
[387.629726] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.276s)
[387.937451] Subtest plane-all-transition-nonblocking-fencing: SUCCESS (6.393s)
[388.755759] [109/133] (643s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-move)
[388.852241] Starting subtest: fbc-2p-primscrn-spr-indfb-move
[388.854010] Subtest fbc-2p-primscrn-spr-indfb-move: SKIP (0.000s)
[388.948947] [110/133] (643s left) syncobj_timeline (invalid-multi-wait-all-unsubmitted-signaled)
[389.009125] Starting subtest: invalid-multi-wait-all-unsubmitted-signaled
[389.010016] Subtest invalid-multi-wait-all-unsubmitted-signaled: SUCCESS (0.001s)
[389.109048] [111/133] (643s left) kms_psr (fbc-pr-primary-blt)
[389.198428] Starting subtest: fbc-pr-primary-blt
[389.200328] Subtest fbc-pr-primary-blt: SKIP (0.000s)
[389.299038] [112/133] (643s left) drm_mm (drm_mm)
[389.334074] Starting subtest: drm_mm
[389.346848] Starting dynamic subtest: drm_test_mm_init
[389.442785] Dynamic subtest drm_test_mm_init: SUCCESS (0.096s)
[389.452386] Starting dynamic subtest: drm_test_mm_debug
[389.527593] Dynamic subtest drm_test_mm_debug: SUCCESS (0.084s)
[389.536503] Starting dynamic subtest: drm_test_mm_align32
[389.616181] Dynamic subtest drm_test_mm_align32: SUCCESS (0.089s)
[389.625211] Starting dynamic subtest: drm_test_mm_align64
[389.706195] Dynamic subtest drm_test_mm_align64: SUCCESS (0.090s)
[389.715494] Starting dynamic subtest: drm_test_mm_lowest
[389.799369] Dynamic subtest drm_test_mm_lowest: SUCCESS (0.091s)
[389.806843] Starting dynamic subtest: drm_test_mm_highest
[389.885026] Dynamic subtest drm_test_mm_highest: SUCCESS (0.085s)
[389.886042] Subtest drm_mm: SUCCESS (0.552s)
[390.049346] [113/133] (642s left) kms_psr (fbc-psr2-sprite-blt)
[390.135555] Starting subtest: fbc-psr2-sprite-blt
[390.136514] Starting dynamic subtest: eDP-1
[390.138331] Dynamic subtest eDP-1: SKIP (0.000s)
[390.140130] Subtest fbc-psr2-sprite-blt: SKIP (0.001s)
[390.204738] [114/133] (642s left) kms_content_protection (lic-type-0)
[390.351483] Starting subtest: lic-type-0
[390.353448] Subtest lic-type-0: SKIP (0.000s)
[390.463418] [115/133] (642s left) gem_ctx_persistence (hang)
[390.515552] Starting subtest: hang
[390.517290] Subtest hang: SKIP (0.000s)
[390.608538] [116/133] (642s left) gem_exec_balancer (hog)
[390.671942] Starting subtest: hog
[390.673628] Subtest hog: SKIP (0.000s)
[390.963925] [117/133] (641s left) gem_exec_store (pages)
[391.019325] Starting subtest: pages
[391.020263] Starting dynamic subtest: rcs0
[391.100985] Dynamic subtest rcs0: SUCCESS (0.082s)
[391.111027] Starting dynamic subtest: bcs0
[391.165059] Dynamic subtest bcs0: SUCCESS (0.063s)
[391.174953] Starting dynamic subtest: vcs0
[391.232096] Dynamic subtest vcs0: SUCCESS (0.066s)
[391.241128] Starting dynamic subtest: vcs1
[391.304147] Dynamic subtest vcs1: SUCCESS (0.071s)
[391.313750] Starting dynamic subtest: vecs0
[391.373913] Dynamic subtest vecs0: SUCCESS (0.069s)
[391.384143] Starting dynamic subtest: ccs0
[391.441253] Dynamic subtest ccs0: SUCCESS (0.066s)
[391.442725] Subtest pages: SUCCESS (0.423s)
[391.619255] [118/133] (641s left) gem_spin_batch (legacy-resubmit-new)
[391.678549] Starting subtest: legacy-resubmit-new
[391.679477] Starting dynamic subtest: default
[391.685966] Dynamic subtest default: SUCCESS (0.009s)
[391.694874] Starting dynamic subtest: render
[391.695878] Dynamic subtest render: SUCCESS (0.006s)
[391.703521] Starting dynamic subtest: bsd
[391.705955] Dynamic subtest bsd: SUCCESS (0.009s)
[391.715020] Starting dynamic subtest: bsd1
[391.715997] Dynamic subtest bsd1: SUCCESS (0.009s)
[391.736144] Starting dynamic subtest: bsd2
[391.737274] Dynamic subtest bsd2: SUCCESS (0.004s)
[391.752818] Starting dynamic subtest: blt
[391.753739] Dynamic subtest blt: SUCCESS (0.006s)
[391.767497] Starting dynamic subtest: vebox
[391.768353] Dynamic subtest vebox: SUCCESS (0.005s)
[391.769373] Subtest legacy-resubmit-new: SUCCESS (0.061s)
[392.817040] [119/133] (640s left) syncobj_timeline (device-submit-unordered)
[392.870033] Starting subtest: device-submit-unordered
[392.870962] Subtest device-submit-unordered: SUCCESS (0.001s)
[392.966280] [120/133] (639s left) kms_plane (plane-position-covered)
[393.056722] Starting subtest: plane-position-covered
[393.591573] Starting dynamic subtest: pipe-A-plane-1
[394.886801] Dynamic subtest pipe-A-plane-1: SUCCESS (1.294s)
[394.894508] Starting dynamic subtest: pipe-A-plane-2
[396.177185] Dynamic subtest pipe-A-plane-2: SUCCESS (1.290s)
[396.186030] Starting dynamic subtest: pipe-A-plane-3
[397.429951] Dynamic subtest pipe-A-plane-3: SUCCESS (1.250s)
[397.437995] Starting dynamic subtest: pipe-A-plane-4
[398.782654] Dynamic subtest pipe-A-plane-4: SUCCESS (1.349s)
[398.795506] Starting dynamic subtest: pipe-A-plane-5
[398.805590] Dynamic subtest pipe-A-plane-5: SUCCESS (0.023s)
[400.019282] Starting dynamic subtest: pipe-B-plane-1
[401.371560] Dynamic subtest pipe-B-plane-1: SUCCESS (1.362s)
[401.379297] Starting dynamic subtest: pipe-B-plane-2
[402.692784] Dynamic subtest pipe-B-plane-2: SUCCESS (1.318s)
[402.700809] Starting dynamic subtest: pipe-B-plane-3
[404.018269] Dynamic subtest pipe-B-plane-3: SUCCESS (1.325s)
[404.026018] Starting dynamic subtest: pipe-B-plane-4
[405.340562] Dynamic subtest pipe-B-plane-4: SUCCESS (1.320s)
[405.348391] Starting dynamic subtest: pipe-B-plane-5
[405.366558] Dynamic subtest pipe-B-plane-5: SUCCESS (0.025s)
[405.368065] Subtest plane-position-covered: SUCCESS (12.304s)
[406.221161] [121/133] (626s left) kms_cursor_crc (cursor-random-64x21)
[406.418076] Starting subtest: cursor-random-64x21
[406.464097] Subtest cursor-random-64x21: SKIP (0.043s)
[406.702561] [122/133] (626s left) kms_pm_rpm (dpms-mode-unset-lpsp)
[409.040356] Starting subtest: dpms-mode-unset-lpsp
[413.096570] Subtest dpms-mode-unset-lpsp: SUCCESS (4.057s)
[413.469628] [123/133] (619s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-mmap-gtt)
[413.563361] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-mmap-gtt
[413.565153] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[413.651092] [124/133] (619s left) syncobj_basic (bad-flags-fd-to-handle)
[413.702572] Starting subtest: bad-flags-fd-to-handle
[413.703710] Subtest bad-flags-fd-to-handle: SUCCESS (0.000s)
[413.805719] [125/133] (619s left) kms_prop_blob (blob-multiple)
[413.859184] Starting subtest: blob-multiple
[413.861550] Subtest blob-multiple: SUCCESS (0.002s)
[413.969123] [126/133] (619s left) perf (enable-disable)
[414.096766] Starting subtest: enable-disable
[414.097637] Starting dynamic subtest: 0-rcs0
[416.376645] Dynamic subtest 0-rcs0: SUCCESS (2.270s)
[416.385337] Starting dynamic subtest: 1-vecs0
[420.853574] Dynamic subtest 1-vecs0: SUCCESS (4.474s)
[420.855163] Subtest enable-disable: SUCCESS (6.746s)
[420.889741] [127/133] (612s left) gem_mmap_offset (open-flood)
[420.937383] Starting subtest: open-flood
[442.438179] Subtest open-flood: SUCCESS (21.490s)
[442.554777] [128/133] (590s left) kms_psr (fbc-psr2-sprite-mmap-cpu)
[442.643700] Starting subtest: fbc-psr2-sprite-mmap-cpu
[442.644776] Starting dynamic subtest: eDP-1
[442.646478] Dynamic subtest eDP-1: SKIP (0.000s)
[442.648164] Subtest fbc-psr2-sprite-mmap-cpu: SKIP (0.001s)
[442.727351] [129/133] (590s left) gem_busy (semaphore)
[442.902871] Subtest semaphore: SKIP (0.000s)
[443.134392] [130/133] (590s left) sysfs_heartbeat_interval (idempotent)
[443.181256] Starting subtest: idempotent
[443.182382] Starting dynamic subtest: vecs0
[443.183439] Dynamic subtest vecs0: SUCCESS (0.001s)
[443.193324] Starting dynamic subtest: ccs0
[443.194436] Dynamic subtest ccs0: SUCCESS (0.001s)
[443.204368] Starting dynamic subtest: vcs0
[443.205289] Dynamic subtest vcs0: SUCCESS (0.000s)
[443.212872] Starting dynamic subtest: bcs0
[443.213755] Dynamic subtest bcs0: SUCCESS (0.001s)
[443.223758] Starting dynamic subtest: rcs0
[443.225378] Dynamic subtest rcs0: SUCCESS (0.001s)
[443.233216] Starting dynamic subtest: vcs1
[443.234310] Dynamic subtest vcs1: SUCCESS (0.000s)
[443.235437] Subtest idempotent: SUCCESS (0.007s)
[443.286412] [131/133] (589s left) kms_flip (nonblocking-read)
[443.378843] Starting subtest: nonblocking-read
[443.379661] Subtest nonblocking-read: SUCCESS (0.000s)
[443.455568] [132/133] (589s left) syncobj_timeline (multi-wait-all-for-submit-available-submitted)
[443.511344] Starting subtest: multi-wait-all-for-submit-available-submitted
[443.512420] Subtest multi-wait-all-for-submit-available-submitted: SUCCESS (0.000s)
[443.630405] [133/133] (589s left) kms_ccs (crc-sprite-planes-basic-4-tiled-mtl-rc-ccs-cc)
[443.714172] Starting subtest: crc-sprite-planes-basic-4-tiled-mtl-rc-ccs-cc
[443.715057] Starting dynamic subtest: pipe-A-eDP-1
[444.220087] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.496s)
[444.228668] Starting dynamic subtest: pipe-B-eDP-1
[445.780139] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.556s)
[445.788731] Starting dynamic subtest: pipe-C-eDP-1
[447.206009] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.425s)
[447.214770] Starting dynamic subtest: pipe-D-eDP-1
[448.630867] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.425s)
[448.631763] Subtest crc-sprite-planes-basic-4-tiled-mtl-rc-ccs-cc: SUCCESS (4.907s)
[449.800973] Closing watchdogs
results: parsing output: 0/ for test: kms_cursor_legacy
results: parsing output: 1/ for test: kms_big_fb
results: parsing output: 2/ for test: kms_frontbuffer_tracking
results: parsing output: 3/ for test: kms_plane_scaling
results: parsing output: 4/ for test: kms_properties
results: parsing output: 5/ for test: syncobj_timeline
results: parsing output: 6/ for test: gem_tiling_max_stride
results: parsing output: 7/ for test: kms_frontbuffer_tracking
results: parsing output: 8/ for test: kms_frontbuffer_tracking
results: parsing output: 9/ for test: kms_ccs
results: parsing output: 10/ for test: syncobj_basic
results: parsing output: 11/ for test: kms_big_fb
results: parsing output: 12/ for test: kms_frontbuffer_tracking
results: parsing output: 13/ for test: gen9_exec_parse
results: parsing output: 14/ for test: kms_scaling_modes
results: parsing output: 15/ for test: api_intel_bb
results: parsing output: 16/ for test: gem_exec_fence
results: parsing output: 17/ for test: gem_media_fill
results: parsing output: 18/ for test: kms_frontbuffer_tracking
results: parsing output: 19/ for test: kms_flip_scaled_crc
results: parsing output: 20/ for test: kms_lease
results: parsing output: 21/ for test: kms_hdr
results: parsing output: 22/ for test: kms_psr
results: parsing output: 23/ for test: kms_big_fb
results: parsing output: 24/ for test: i915_hangman
results: parsing output: 25/ for test: i915_pm_rps
results: parsing output: 26/ for test: kms_big_fb
results: parsing output: 27/ for test: kms_frontbuffer_tracking
results: parsing output: 28/ for test: kms_frontbuffer_tracking
results: parsing output: 29/ for test: api_intel_bb
results: parsing output: 30/ for test: kms_plane
results: parsing output: 31/ for test: kms_flip
results: parsing output: 32/ for test: kms_frontbuffer_tracking
results: parsing output: 33/ for test: kms_cursor_legacy
results: parsing output: 34/ for test: gem_ringfill
results: parsing output: 35/ for test: kms_big_fb
results: parsing output: 36/ for test: kms_big_fb
results: parsing output: 37/ for test: gem_mmap_gtt
results: parsing output: 38/ for test: kms_frontbuffer_tracking
results: parsing output: 39/ for test: kms_addfb_basic
results: parsing output: 40/ for test: sriov_basic
results: parsing output: 41/ for test: syncobj_wait
results: parsing output: 42/ for test: kms_rotation_crc
results: parsing output: 43/ for test: gem_exec_reloc
results: parsing output: 44/ for test: gem_exercise_blt
results: parsing output: 45/ for test: kms_frontbuffer_tracking
results: parsing output: 46/ for test: kms_cursor_crc
results: parsing output: 47/ for test: kms_cursor_legacy
results: parsing output: 48/ for test: kms_atomic
results: parsing output: 49/ for test: kms_frontbuffer_tracking
results: parsing output: 50/ for test: gem_ctx_shared
results: parsing output: 51/ for test: gem_exec_reloc
results: parsing output: 52/ for test: gem_mmap_wc
results: parsing output: 53/ for test: kms_sequence
results: parsing output: 54/ for test: kms_flip_scaled_crc
results: parsing output: 55/ for test: gem_exec_schedule
results: parsing output: 56/ for test: kms_pm_rpm
results: parsing output: 57/ for test: i915_drm_fdinfo
results: parsing output: 58/ for test: kms_color
results: parsing output: 59/ for test: kms_dsc
results: parsing output: 60/ for test: i915_pm_rps
results: parsing output: 61/ for test: kms_psr2_sf
results: parsing output: 62/ for test: kms_ccs
results: parsing output: 63/ for test: kms_atomic_interruptible
results: parsing output: 64/ for test: kms_big_fb
results: parsing output: 65/ for test: gem_pxp
results: parsing output: 66/ for test: gem_userptr_blits
results: parsing output: 67/ for test: gem_sync
results: parsing output: 68/ for test: kms_frontbuffer_tracking
results: parsing output: 69/ for test: gem_pxp
results: parsing output: 70/ for test: prime_vgem
results: parsing output: 71/ for test: kms_chamelium_frames
results: parsing output: 72/ for test: kms_frontbuffer_tracking
results: parsing output: 73/ for test: kms_frontbuffer_tracking
results: parsing output: 74/ for test: vgem_basic
results: parsing output: 75/ for test: kms_psr
results: parsing output: 76/ for test: kms_cursor_legacy
results: parsing output: 77/ for test: kms_ccs
results: parsing output: 78/ for test: gem_fenced_exec_thrash
results: parsing output: 79/ for test: template
results: parsing output: 80/ for test: kms_ccs
results: parsing output: 81/ for test: syncobj_wait
results: parsing output: 82/ for test: kms_vblank
results: parsing output: 83/ for test: kms_frontbuffer_tracking
results: parsing output: 84/ for test: syncobj_wait
results: parsing output: 85/ for test: kms_cursor_legacy
results: parsing output: 86/ for test: kms_flip
results: parsing output: 87/ for test: gem_ctx_persistence
results: parsing output: 88/ for test: gem_workarounds
results: parsing output: 89/ for test: gem_ctx_engines
results: parsing output: 90/ for test: gem_exec_fence
results: parsing output: 91/ for test: kms_vrr
results: parsing output: 92/ for test: kms_pipe_b_c_ivb
results: parsing output: 93/ for test: gem_exec_reloc
results: parsing output: 94/ for test: kms_plane
results: parsing output: 95/ for test: vgem_basic
results: parsing output: 96/ for test: perf_pmu
results: parsing output: 97/ for test: syncobj_timeline
results: parsing output: 98/ for test: gem_watchdog
results: parsing output: 99/ for test: kms_getfb
results: parsing output: 100/ for test: gem_exec_balancer
results: parsing output: 101/ for test: gem_exec_reloc
results: parsing output: 102/ for test: kms_mmap_write_crc
results: parsing output: 103/ for test: gem_exec_schedule
results: parsing output: 104/ for test: gem_userptr_blits
results: parsing output: 105/ for test: kms_frontbuffer_tracking
results: parsing output: 106/ for test: kms_chamelium_hpd
results: parsing output: 107/ for test: kms_atomic_transition
results: parsing output: 108/ for test: kms_frontbuffer_tracking
results: parsing output: 109/ for test: syncobj_timeline
results: parsing output: 110/ for test: kms_psr
results: parsing output: 111/ for test: drm_mm
results: parsing output: 112/ for test: kms_psr
results: parsing output: 113/ for test: kms_content_protection
results: parsing output: 114/ for test: gem_ctx_persistence
results: parsing output: 115/ for test: gem_exec_balancer
results: parsing output: 116/ for test: gem_exec_store
results: parsing output: 117/ for test: gem_spin_batch
results: parsing output: 118/ for test: syncobj_timeline
results: parsing output: 119/ for test: kms_plane
results: parsing output: 120/ for test: kms_cursor_crc
results: parsing output: 121/ for test: kms_pm_rpm
results: parsing output: 122/ for test: kms_frontbuffer_tracking
results: parsing output: 123/ for test: syncobj_basic
results: parsing output: 124/ for test: kms_prop_blob
results: parsing output: 125/ for test: perf
results: parsing output: 126/ for test: gem_mmap_offset
results: parsing output: 127/ for test: kms_psr
results: parsing output: 128/ for test: gem_busy
results: parsing output: 129/ for test: sysfs_heartbeat_interval
results: parsing output: 130/ for test: kms_flip
results: parsing output: 131/ for test: syncobj_timeline
results: parsing output: 132/ for test: kms_ccs
Done.