[57.640830] Initializing watchdogs
[57.640888]   /dev/watchdog0
[57.655546] [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]
[57.660263] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[57.662547] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[57.665933] [001/132] (960s left) syncobj_basic (bad-destroy)
[57.754330] Starting subtest: bad-destroy
[57.756663] Subtest bad-destroy: SUCCESS (0.000s)
[57.860950] [002/132] (960s left) kms_plane_scaling (plane-downscale-factor-0-5-with-modifiers)
[57.957801] Starting subtest: plane-downscale-factor-0-5-with-modifiers
[57.960111] Starting dynamic subtest: pipe-A
[57.979860] Dynamic subtest pipe-A: SKIP (0.019s)
[57.987830] Starting dynamic subtest: pipe-B
[58.018075] Dynamic subtest pipe-B: SKIP (0.036s)
[58.025370] Starting dynamic subtest: pipe-C
[58.053776] Dynamic subtest pipe-C: SKIP (0.035s)
[58.060883] Starting dynamic subtest: pipe-D
[58.087847] Dynamic subtest pipe-D: SKIP (0.035s)
[58.092242] Subtest plane-downscale-factor-0-5-with-modifiers: SKIP (0.127s)
[58.190521] [003/132] (960s left) i915_pm_rps (waitboost)
[58.256085] Starting subtest: waitboost
[64.594642] Subtest waitboost: SUCCESS (6.299s)
[64.667958] [004/132] (953s left) kms_feature_discovery (display)
[64.768141] Starting subtest: display
[64.770477] Subtest display: SUCCESS (0.000s)
[64.853165] [005/132] (953s left) gem_exec_reloc (basic-wc-read)
[64.917939] Subtest basic-wc-read: SKIP (0.000s)
[64.983698] [006/132] (953s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-blt)
[65.074768] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-blt
[71.852049] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-blt: SUCCESS (6.765s)
[71.974149] [007/132] (946s left) kms_atomic_interruptible (universal-setplane-primary)
[72.064317] Starting subtest: universal-setplane-primary
[72.066591] Starting dynamic subtest: pipe-A-eDP-1
[79.524475] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.453s)
[79.526879] Subtest universal-setplane-primary: SUCCESS (7.454s)
[80.376441] [008/132] (938s left) kms_psr (psr-cursor-render)
[80.480194] Starting subtest: psr-cursor-render
[80.482586] Starting dynamic subtest: eDP-1
[82.161281] Dynamic subtest eDP-1: SUCCESS (1.681s)
[82.163588] Subtest psr-cursor-render: SUCCESS (1.682s)
[83.023937] [009/132] (935s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-180-async-flip)
[83.127417] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-180-async-flip
[83.131966] Subtest y-tiled-max-hw-stride-64bpp-rotate-180-async-flip: SKIP (0.000s)
[83.221563] [010/132] (935s left) gem_exec_fence (syncobj-import)
[83.697300] Starting subtest: syncobj-import
[83.701845] Subtest syncobj-import: SUCCESS (0.005s)
[84.959270] [FACT gem_exec_fence (syncobj-import)] new: kernel.kmod_is_loaded.vgem: true
[84.962484] [011/132] (933s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-downscaling)
[85.058889] Starting subtest: flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-downscaling
[85.063581] Subtest flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-downscaling: SKIP (0.000s)
[85.129309] [012/132] (933s left) prime_mmap (test_aperture_limit)
[85.185754] Starting subtest: test_aperture_limit
[85.187721] Starting dynamic subtest: test_aperture_limit-smem
[85.194339] Dynamic subtest test_aperture_limit-smem: SKIP (0.008s)
[85.198854] Subtest test_aperture_limit: SKIP (0.008s)
[85.286187] [013/132] (933s left) syncobj_timeline (wait-zero-handles)
[85.340648] Starting subtest: wait-zero-handles
[85.343043] Subtest wait-zero-handles: SUCCESS (0.000s)
[85.435819] [014/132] (933s left) gem_eio (wait-10ms)
[85.666588] Starting subtest: wait-10ms
[86.022038] Subtest wait-10ms: SUCCESS (0.356s)
[86.177949] [015/132] (932s left) kms_frontbuffer_tracking (psr-rgb565-draw-render)
[86.272063] Starting subtest: psr-rgb565-draw-render
[93.270036] Subtest psr-rgb565-draw-render: SUCCESS (6.997s)
[93.386163] [016/132] (925s left) kms_ccs (bad-rotation-90-yf-tiled-ccs)
[93.490910] Starting subtest: bad-rotation-90-yf-tiled-ccs
[93.493322] Starting dynamic subtest: pipe-A-eDP-1
[93.516500] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[93.526668] Starting dynamic subtest: pipe-B-eDP-1
[93.547964] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[93.555791] Starting dynamic subtest: pipe-C-eDP-1
[93.577131] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[93.584816] Starting dynamic subtest: pipe-D-eDP-1
[93.606416] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[93.610454] Subtest bad-rotation-90-yf-tiled-ccs: SKIP (0.003s)
[95.822211] [017/132] (922s left) gem_exec_reloc (basic-cpu-active)
[95.880399] Subtest basic-cpu-active: SKIP (0.000s)
[95.955024] [018/132] (922s left) kms_flip (flip-vs-wf_vblank-interruptible)
[96.048999] Starting subtest: flip-vs-wf_vblank-interruptible
[96.051485] Starting dynamic subtest: A-eDP1
[97.957823] Dynamic subtest A-eDP1: SUCCESS (1.906s)
[97.968334] Starting dynamic subtest: B-eDP1
[99.900737] Dynamic subtest B-eDP1: SUCCESS (1.942s)
[99.911814] Starting dynamic subtest: C-eDP1
[101.822536] Dynamic subtest C-eDP1: SUCCESS (1.920s)
[101.831654] Starting dynamic subtest: D-eDP1
[103.745689] Dynamic subtest D-eDP1: SUCCESS (1.922s)
[103.748196] Subtest flip-vs-wf_vblank-interruptible: SUCCESS (7.697s)
[104.970140] [019/132] (913s left) gem_pread (uncached)
[105.040386] Subtest uncached: SKIP (0.000s)
[105.103819] [020/132] (913s left) kms_big_fb (y-tiled-64bpp-rotate-0)
[105.202719] Starting subtest: y-tiled-64bpp-rotate-0
[105.207196] Subtest y-tiled-64bpp-rotate-0: SKIP (0.000s)
[105.321579] [021/132] (913s left) gem_exec_schedule (timeslicing)
[105.398310] Starting subtest: timeslicing
[105.400642] Starting dynamic subtest: rcs0
[105.410533] Dynamic subtest rcs0: SUCCESS (0.021s)
[105.420707] Starting dynamic subtest: bcs0
[105.431386] Dynamic subtest bcs0: SUCCESS (0.020s)
[105.439611] Starting dynamic subtest: vcs0
[105.451566] Dynamic subtest vcs0: SUCCESS (0.020s)
[105.460553] Starting dynamic subtest: vcs1
[105.470272] Dynamic subtest vcs1: SUCCESS (0.018s)
[105.478056] Starting dynamic subtest: vecs0
[105.489057] Dynamic subtest vecs0: SUCCESS (0.018s)
[105.497028] Starting dynamic subtest: ccs0
[105.511036] Dynamic subtest ccs0: SUCCESS (0.021s)
[105.513791] Subtest timeslicing: SUCCESS (0.122s)
[106.959330] [022/132] (912s left) i915_pm_rps (basic-api)
[107.021448] Starting subtest: basic-api
[107.025714] Subtest basic-api: SKIP (0.000s)
[107.121475] [023/132] (911s left) kms_lease (lease-invalid-crtc)
[107.212742] Starting subtest: lease-invalid-crtc
[107.215106] Starting dynamic subtest: pipe-A-eDP-1
[107.217039] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s)
[107.225693] Starting dynamic subtest: pipe-B-eDP-1
[107.228037] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[107.235974] Starting dynamic subtest: pipe-C-eDP-1
[107.238246] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[107.245729] Starting dynamic subtest: pipe-D-eDP-1
[107.247661] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[107.249612] Subtest lease-invalid-crtc: SUCCESS (0.003s)
[107.285477] [024/132] (911s left) gem_pxp (verify-pxp-key-change-after-suspend-resume)
[107.409705] Starting subtest: verify-pxp-key-change-after-suspend-resume
[114.697376] Subtest verify-pxp-key-change-after-suspend-resume: SUCCESS (7.289s)
[114.820282] [025/132] (904s left) drm_mm (drm_mm)
[114.874284] Starting subtest: drm_mm
[114.883083] Starting dynamic subtest: drm_test_mm_init
[114.989532] Dynamic subtest drm_test_mm_init: SUCCESS (0.106s)
[115.000292] Starting dynamic subtest: drm_test_mm_debug
[115.090255] Dynamic subtest drm_test_mm_debug: SUCCESS (0.101s)
[115.098652] Starting dynamic subtest: drm_test_mm_align32
[115.194194] Dynamic subtest drm_test_mm_align32: SUCCESS (0.102s)
[115.203274] Starting dynamic subtest: drm_test_mm_align64
[115.286602] Dynamic subtest drm_test_mm_align64: SUCCESS (0.093s)
[115.296427] Starting dynamic subtest: drm_test_mm_lowest
[115.385917] Dynamic subtest drm_test_mm_lowest: SUCCESS (0.099s)
[115.393917] Starting dynamic subtest: drm_test_mm_highest
[115.493937] Dynamic subtest drm_test_mm_highest: SUCCESS (0.108s)
[115.495884] Subtest drm_mm: SUCCESS (0.621s)
[115.681274] [026/132] (903s left) gem_exec_params (secure-non-master)
[115.740773] Starting subtest: secure-non-master
[115.745337] Subtest secure-non-master: SKIP (0.000s)
[115.852546] [027/132] (903s left) perf (unprivileged-single-ctx-counters)
[115.976189] Starting subtest: unprivileged-single-ctx-counters
[115.980265] Subtest unprivileged-single-ctx-counters: SKIP (0.000s)
[116.021540] [028/132] (903s left) kms_ccs (crc-sprite-planes-basic-4-tiled-mtl-mc-ccs)
[116.119151] Starting subtest: crc-sprite-planes-basic-4-tiled-mtl-mc-ccs
[116.121144] Starting dynamic subtest: pipe-A-eDP-1
[116.404783] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.261s)
[116.414510] Starting dynamic subtest: pipe-B-eDP-1
[117.695514] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.281s)
[117.706780] Starting dynamic subtest: pipe-C-eDP-1
[118.954810] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.258s)
[118.965068] Starting dynamic subtest: pipe-D-eDP-1
[120.183752] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.229s)
[120.186118] Subtest crc-sprite-planes-basic-4-tiled-mtl-mc-ccs: SUCCESS (4.032s)
[121.292041] [029/132] (897s left) kms_dirtyfb (fbc-dirtyfb-ioctl)
[121.392110] Starting subtest: fbc-dirtyfb-ioctl
[121.394463] Starting dynamic subtest: A-eDP-1
[123.975085] Dynamic subtest A-eDP-1: SUCCESS (2.582s)
[123.977688] Subtest fbc-dirtyfb-ioctl: SUCCESS (2.583s)
[124.868264] [030/132] (894s left) kms_frontbuffer_tracking (fbcpsr-suspend)
[124.967541] Starting subtest: fbcpsr-suspend
[165.053038] Subtest fbcpsr-suspend: SUCCESS (10.113s)
[165.168141] [031/132] (854s left) kms_pipe_crc_basic (compare-crc-sanitycheck-xr24)
[165.285810] Starting subtest: compare-crc-sanitycheck-xr24
[165.288098] Starting dynamic subtest: pipe-A-eDP-1
[165.952417] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.652s)
[165.964854] Starting dynamic subtest: pipe-B-eDP-1
[167.293718] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.313s)
[167.304173] Starting dynamic subtest: pipe-C-eDP-1
[168.583825] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.266s)
[168.593802] Starting dynamic subtest: pipe-D-eDP-1
[169.822916] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.222s)
[169.825249] Subtest compare-crc-sanitycheck-xr24: SUCCESS (4.459s)
[170.673634] [032/132] (848s left) kms_psr (fbc-pr-sprite-blt)
[170.777491] Starting subtest: fbc-pr-sprite-blt
[170.782022] Subtest fbc-pr-sprite-blt: SKIP (0.000s)
[170.867986] [033/132] (848s left) kms_plane_scaling (planes-upscale-20x20)
[170.962320] Starting subtest: planes-upscale-20x20
[170.964483] Starting dynamic subtest: pipe-A
[171.023859] Dynamic subtest pipe-A: SUCCESS (0.062s)
[171.033873] Starting dynamic subtest: pipe-B
[172.215501] Dynamic subtest pipe-B: SUCCESS (1.179s)
[172.226922] Starting dynamic subtest: pipe-C
[173.340392] Dynamic subtest pipe-C: SUCCESS (1.114s)
[173.350369] Starting dynamic subtest: pipe-D
[174.480773] Dynamic subtest pipe-D: SUCCESS (1.131s)
[174.483163] Subtest planes-upscale-20x20: SUCCESS (3.489s)
[175.652988] [034/132] (843s left) gen7_exec_parse (oacontrol-tracking)
[175.709631] Subtest oacontrol-tracking: SKIP (0.000s)
[175.771802] [035/132] (843s left) kms_atomic_transition (plane-all-transition)
[175.878260] Starting subtest: plane-all-transition
[175.880610] Starting dynamic subtest: pipe-A-eDP-1
[178.387211] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.497s)
[178.697434] Starting dynamic subtest: pipe-B-eDP-1
[181.903669] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.204s)
[182.208153] Subtest plane-all-transition: SUCCESS (6.302s)
[183.029641] [036/132] (836s left) kms_psr (fbc-psr-cursor-plane-move)
[183.143638] Starting subtest: fbc-psr-cursor-plane-move
[183.145802] Starting dynamic subtest: eDP-1
[183.149711] Dynamic subtest eDP-1: SKIP (0.000s)
[183.153829] Subtest fbc-psr-cursor-plane-move: SKIP (0.001s)
[183.243397] [037/132] (836s left) gem_softpin (noreloc)
[183.307305] Starting subtest: noreloc
[188.738130] Subtest noreloc: SUCCESS (5.418s)
[188.887504] [038/132] (830s left) kms_content_protection (atomic-hdcp14)
[189.033993] Starting subtest: atomic-hdcp14
[189.038255] Subtest atomic-hdcp14: SKIP (0.000s)
[189.157272] [039/132] (830s left) syncobj_eventfd (timeline-wait-signaled)
[189.216408] Starting subtest: timeline-wait-signaled
[189.218747] Subtest timeline-wait-signaled: SUCCESS (0.001s)
[189.319220] [040/132] (830s left) syncobj_timeline (etime-single-wait-for-submit-available-unsubmitted)
[189.365737] Starting subtest: etime-single-wait-for-submit-available-unsubmitted
[189.466552] Subtest etime-single-wait-for-submit-available-unsubmitted: SUCCESS (0.102s)
[189.543771] [041/132] (830s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-mmap-wc)
[189.640443] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-mmap-wc
[196.265542] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-mmap-wc: SUCCESS (6.624s)
[196.390416] [042/132] (823s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-180)
[196.500698] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-180
[197.524613] Subtest x-tiled-max-hw-stride-64bpp-rotate-180: SUCCESS (1.024s)
[197.647441] [043/132] (822s left) kms_flip (2x-plain-flip-fb-recreate-interruptible)
[197.739886] Starting subtest: 2x-plain-flip-fb-recreate-interruptible
[197.750425] Subtest 2x-plain-flip-fb-recreate-interruptible: SKIP (0.011s)
[197.841719] [044/132] (822s left) kms_flip_scaled_crc (flip-32bpp-xtile-to-64bpp-xtile-upscaling)
[197.942118] Starting subtest: flip-32bpp-xtile-to-64bpp-xtile-upscaling
[197.944059] Starting dynamic subtest: pipe-A-default-mode
[200.718365] Dynamic subtest pipe-A-default-mode: SUCCESS (2.779s)
[200.720515] Subtest flip-32bpp-xtile-to-64bpp-xtile-upscaling: SUCCESS (2.780s)
[201.585951] [045/132] (818s left) kms_chamelium_audio (hdmi-audio-edid)
[201.973423] Subtest hdmi-audio-edid: SKIP (0.000s)
[202.795899] [046/132] (817s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-blt)
[202.897558] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-blt
[202.901795] Subtest fbc-2p-primscrn-pri-indfb-draw-blt: SKIP (0.000s)
[203.003213] [047/132] (817s left) syncobj_wait (invalid-multi-wait-all-unsubmitted-submitted)
[203.056635] Starting subtest: invalid-multi-wait-all-unsubmitted-submitted
[203.058880] Subtest invalid-multi-wait-all-unsubmitted-submitted: SUCCESS (0.000s)
[203.159913] [048/132] (816s left) gem_exec_parallel (engines)
[203.219986] Starting subtest: engines
[203.222390] Starting dynamic subtest: basic
[204.737930] Dynamic subtest basic: SUCCESS (1.520s)
[204.747854] Starting dynamic subtest: contexts
[209.138141] Dynamic subtest contexts: SUCCESS (4.397s)
[209.148239] Starting dynamic subtest: fds
[212.955410] Dynamic subtest fds: SUCCESS (3.815s)
[212.969404] Starting dynamic subtest: userptr
[214.720645] Dynamic subtest userptr: SUCCESS (1.764s)
[214.723518] Subtest engines: SUCCESS (11.503s)
[214.912112] [049/132] (805s left) kms_cursor_legacy (2x-flip-vs-cursor-atomic)
[215.027994] Starting subtest: 2x-flip-vs-cursor-atomic
[215.032484] Subtest 2x-flip-vs-cursor-atomic: SKIP (0.001s)
[215.172295] [050/132] (805s left) gem_ctx_sseu (invalid-args)
[215.238894] Subtest invalid-args: SKIP (0.000s)
[215.301027] [051/132] (804s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size)
[215.418077] Starting subtest: basic-flip-before-cursor-varying-size
[216.360483] Subtest basic-flip-before-cursor-varying-size: SUCCESS (0.942s)
[217.163504] [052/132] (803s left) kms_flip (2x-single-buffer-flip-vs-dpms-off-vs-modeset)
[217.258671] Starting subtest: 2x-single-buffer-flip-vs-dpms-off-vs-modeset
[217.267709] Subtest 2x-single-buffer-flip-vs-dpms-off-vs-modeset: SKIP (0.011s)
[217.344632] [053/132] (802s left) kms_ccs (crc-primary-rotation-180-4-tiled-lnl-ccs)
[217.438618] Starting subtest: crc-primary-rotation-180-4-tiled-lnl-ccs
[217.443047] Subtest crc-primary-rotation-180-4-tiled-lnl-ccs: SKIP (0.000s)
[218.591936] [054/132] (801s left) kms_psr (fbc-psr-suspend)
[218.695609] Starting subtest: fbc-psr-suspend
[218.697893] Starting dynamic subtest: eDP-1
[218.702283] Dynamic subtest eDP-1: SKIP (0.000s)
[218.706772] Subtest fbc-psr-suspend: SKIP (0.001s)
[218.769876] [055/132] (801s left) gem_exec_schedule (lateslice)
[218.837153] Starting subtest: lateslice
[218.839047] Starting dynamic subtest: rcs0
[218.848995] Dynamic subtest rcs0: SUCCESS (0.021s)
[218.859179] Starting dynamic subtest: bcs0
[218.867395] Dynamic subtest bcs0: SUCCESS (0.018s)
[218.880014] Starting dynamic subtest: vcs0
[218.885793] Dynamic subtest vcs0: SUCCESS (0.018s)
[218.896287] Starting dynamic subtest: vcs1
[218.906541] Dynamic subtest vcs1: SUCCESS (0.020s)
[218.919767] Starting dynamic subtest: vecs0
[218.926447] Dynamic subtest vecs0: SUCCESS (0.018s)
[218.935633] Starting dynamic subtest: ccs0
[218.943240] Dynamic subtest ccs0: SUCCESS (0.016s)
[218.945496] Subtest lateslice: SUCCESS (0.116s)
[220.886873] [056/132] (799s left) kms_big_fb (linear-8bpp-rotate-0)
[221.003090] Starting subtest: linear-8bpp-rotate-0
[222.261631] Subtest linear-8bpp-rotate-0: SUCCESS (1.258s)
[222.376001] [057/132] (798s left) kms_getfb (getfb-handle-valid)
[222.463210] Starting subtest: getfb-handle-valid
[222.465338] Subtest getfb-handle-valid: SUCCESS (0.000s)
[222.564804] [058/132] (797s left) gem_eio (wait-immediate)
[222.801769] Starting subtest: wait-immediate
[223.193285] Subtest wait-immediate: SUCCESS (0.391s)
[223.337410] [059/132] (797s left) prime_vgem (shrink)
[223.423597] Starting subtest: shrink
[223.459241] Subtest shrink: SUCCESS (0.038s)
[223.576948] [060/132] (797s left) gem_exec_flush (basic-wb-ro-before-default)
[223.635913] Starting subtest: basic-wb-ro-before-default
[229.095752] Subtest basic-wb-ro-before-default: SUCCESS (5.458s)
[229.296432] [061/132] (791s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-gtt)
[229.396029] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-gtt
[229.400353] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[229.504054] [062/132] (791s left) kms_properties (colorop-properties-legacy)
[229.600634] Starting subtest: colorop-properties-legacy
[229.602526] Starting dynamic subtest: pipe-A-eDP-1
[229.961094] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.359s)
[229.970841] Starting dynamic subtest: pipe-B-eDP-1
[231.048124] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.086s)
[231.058498] Starting dynamic subtest: pipe-C-eDP-1
[232.077683] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.027s)
[232.087211] Starting dynamic subtest: pipe-D-eDP-1
[233.121352] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.041s)
[233.123356] Subtest colorop-properties-legacy: SUCCESS (3.519s)
[233.933196] [063/132] (786s left) kms_psr (psr-cursor-mmap-gtt)
[234.029417] Starting subtest: psr-cursor-mmap-gtt
[234.031888] Starting dynamic subtest: eDP-1
[235.720649] Dynamic subtest eDP-1: SUCCESS (1.692s)
[235.722946] Subtest psr-cursor-mmap-gtt: SUCCESS (1.693s)
[236.601407] [064/132] (784s left) kms_plane (pixel-format-4-tiled-bmg-ccs-modifier)
[236.708395] Starting subtest: pixel-format-4-tiled-bmg-ccs-modifier
[236.712876] Subtest pixel-format-4-tiled-bmg-ccs-modifier: SKIP (0.000s)
[236.792452] [065/132] (784s left) kms_ccs (ccs-on-another-bo-4-tiled-mtl-mc-ccs)
[236.888369] Starting subtest: ccs-on-another-bo-4-tiled-mtl-mc-ccs
[236.890642] Starting dynamic subtest: pipe-A-eDP-1
[236.911301] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.024s)
[236.921967] Starting dynamic subtest: pipe-B-eDP-1
[236.942555] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.023s)
[236.952014] Starting dynamic subtest: pipe-C-eDP-1
[236.972374] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.022s)
[236.982072] Starting dynamic subtest: pipe-D-eDP-1
[237.002439] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.023s)
[237.004748] Subtest ccs-on-another-bo-4-tiled-mtl-mc-ccs: SUCCESS (0.097s)
[239.165557] [066/132] (781s left) kms_invalid_mode (bad-htotal)
[239.254106] Starting subtest: bad-htotal
[239.256385] Starting dynamic subtest: pipe-A-eDP-1
[239.555063] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.300s)
[239.565334] Starting dynamic subtest: pipe-B-eDP-1
[239.567244] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[239.576346] Starting dynamic subtest: pipe-C-eDP-1
[239.578618] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[239.587674] Starting dynamic subtest: pipe-D-eDP-1
[239.589869] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[239.592230] Subtest bad-htotal: SUCCESS (0.306s)
[240.402484] [067/132] (780s left) i915_hangman (error-state-basic)
[240.471484] Starting subtest: error-state-basic
[240.629392] Subtest error-state-basic: SUCCESS (0.159s)
[240.705962] [068/132] (780s left) gem_render_copy (y-tiled-to-vebox-linear)
[240.772993] Starting subtest: y-tiled-to-vebox-linear
[240.777444] Subtest y-tiled-to-vebox-linear: SKIP (0.000s)
[240.965782] [069/132] (780s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-pwrite)
[241.065797] Starting subtest: fbcpsr-rgb565-draw-pwrite
[248.137967] Subtest fbcpsr-rgb565-draw-pwrite: SUCCESS (7.072s)
[248.261748] [070/132] (772s left) kms_cursor_edge_walk (64x64-top-edge)
[248.368359] Starting subtest: 64x64-top-edge
[248.370643] Starting dynamic subtest: pipe-A-eDP-1
[251.801188] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.432s)
[251.812136] Starting dynamic subtest: pipe-D-eDP-1
[254.937556] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.132s)
[254.939928] Subtest 64x64-top-edge: SUCCESS (6.568s)
[255.740473] [071/132] (765s left) kms_pm_rpm (pm-caching)
[257.977402] Starting subtest: pm-caching
[257.982774] Subtest pm-caching: SKIP (0.000s)
[258.365449] [072/132] (762s left) kms_pm_rpm (fences)
[259.898200] Starting subtest: fences
[259.903454] Subtest fences: SKIP (0.000s)
[260.598354] [073/132] (760s left) api_intel_bb (blit-reloc-purge-cache)
[260.657348] Starting subtest: blit-reloc-purge-cache
[260.661686] Subtest blit-reloc-purge-cache: SKIP (0.001s)
[260.793065] [074/132] (760s left) kms_big_fb (4-tiled-32bpp-rotate-0)
[260.896969] Starting subtest: 4-tiled-32bpp-rotate-0
[262.309293] Subtest 4-tiled-32bpp-rotate-0: SUCCESS (1.412s)
[262.435934] [075/132] (758s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-mmap-wc)
[262.533190] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-mmap-wc
[266.730407] Subtest fbc-1p-primscrn-pri-indfb-draw-mmap-wc: SUCCESS (4.201s)
[267.885959] [076/132] (753s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-blt)
[268.018074] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-blt
[268.022389] Subtest psr-2p-scndscrn-spr-indfb-draw-blt: SKIP (0.000s)
[268.138516] [077/132] (753s left) kms_universal_plane (universal-plane-pageflip-windowed)
[268.241600] Starting subtest: universal-plane-pageflip-windowed
[268.243588] Starting dynamic subtest: pipe-A-eDP-1
[268.825260] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.583s)
[268.835738] Starting dynamic subtest: pipe-B-eDP-1
[270.114041] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.287s)
[270.127368] Starting dynamic subtest: pipe-C-eDP-1
[271.321968] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.208s)
[271.332546] Starting dynamic subtest: pipe-D-eDP-1
[272.551499] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.224s)
[272.553517] Subtest universal-plane-pageflip-windowed: SUCCESS (4.310s)
[273.423592] [078/132] (747s left) gem_mmap_offset (perf)
[273.481488] Starting subtest: perf
[273.483401] Starting dynamic subtest: smem0
[273.820786] Dynamic subtest smem0: SUCCESS (0.337s)
[273.823356] Subtest perf: SUCCESS (0.339s)
[273.925527] [079/132] (747s left) kms_cursor_crc (cursor-rapid-movement-256x256)
[274.176334] Starting subtest: cursor-rapid-movement-256x256
[274.178444] Starting dynamic subtest: pipe-A-eDP-1
[274.751429] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.574s)
[274.784195] Starting dynamic subtest: pipe-D-eDP-1
[276.026256] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.250s)
[276.028434] Subtest cursor-rapid-movement-256x256: SUCCESS (1.852s)
[276.860794] [080/132] (744s left) gem_cs_tlb (engines)
[276.921256] Starting subtest: engines
[276.923599] Starting dynamic subtest: rcs0
[279.078941] Dynamic subtest rcs0: SUCCESS (2.153s)
[279.090482] Starting dynamic subtest: bcs0
[281.232589] Dynamic subtest bcs0: SUCCESS (2.152s)
[281.244644] Starting dynamic subtest: vcs0
[283.415290] Dynamic subtest vcs0: SUCCESS (2.155s)
[283.426672] Starting dynamic subtest: vcs1
[285.543109] Dynamic subtest vcs1: SUCCESS (2.153s)
[285.554867] Starting dynamic subtest: vecs0
[287.695917] Dynamic subtest vecs0: SUCCESS (2.152s)
[287.708129] Starting dynamic subtest: ccs0
[289.850348] Dynamic subtest ccs0: SUCCESS (2.154s)
[289.853147] Subtest engines: SUCCESS (12.928s)
[289.992048] [081/132] (731s left) kms_flip (bo-too-big)
[290.088374] Starting subtest: bo-too-big
[290.090434] Starting dynamic subtest: A-eDP1
[291.410795] Dynamic subtest A-eDP1: SUCCESS (1.323s)
[291.422871] Starting dynamic subtest: B-eDP1
[292.736242] Dynamic subtest B-eDP1: SUCCESS (1.324s)
[292.745898] Starting dynamic subtest: C-eDP1
[294.070317] Dynamic subtest C-eDP1: SUCCESS (1.332s)
[294.079882] Starting dynamic subtest: D-eDP1
[295.406371] Dynamic subtest D-eDP1: SUCCESS (1.334s)
[295.408893] Subtest bo-too-big: SUCCESS (5.323s)
[296.615132] [082/132] (724s left) kms_frontbuffer_tracking (fbc-tiling-y)
[296.725405] Starting subtest: fbc-tiling-y
[296.729777] Subtest fbc-tiling-y: SKIP (0.000s)
[296.828545] [083/132] (724s left) gem_userptr_blits (sd-probe)
[296.884774] Starting subtest: sd-probe
[296.886625] Subtest sd-probe: SUCCESS (0.000s)
[297.024396] [084/132] (724s left) gem_ctx_bad_destroy (invalid-default-ctx)
[297.067948] Starting subtest: invalid-default-ctx
[297.070263] Subtest invalid-default-ctx: SUCCESS (0.000s)
[297.148266] [085/132] (724s left) kms_chamelium_hpd (vga-hpd-without-ddc)
[297.566105] Subtest vga-hpd-without-ddc: SKIP (0.000s)
[298.424494] [086/132] (723s left) gem_ctx_persistence (userptr)
[298.489261] Starting subtest: userptr
[298.679280] Subtest userptr: SUCCESS (0.190s)
[298.769451] [087/132] (722s left) perf (whitelisted-registers-userspace-config)
[298.858930] Starting subtest: whitelisted-registers-userspace-config
[298.861252] Subtest whitelisted-registers-userspace-config: SUCCESS (0.001s)
[298.902661] [088/132] (722s left) gem_exec_fence (expired-history)
[299.365781] Starting subtest: expired-history
[306.513885] Subtest expired-history: SUCCESS (7.147s)
[307.088156] [089/132] (714s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip)
[307.190421] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip
[307.195264] Subtest yf-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip: SKIP (0.000s)
[307.284159] [090/132] (714s left) syncobj_wait (wait-for-submit-snapshot)
[307.340945] Starting subtest: wait-for-submit-snapshot
[307.423003] Subtest wait-for-submit-snapshot: SUCCESS (0.081s)
[307.513065] [091/132] (714s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-pwrite)
[307.614862] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-pwrite
[312.920852] Subtest fbc-1p-primscrn-pri-indfb-draw-pwrite: SUCCESS (5.307s)
[314.055236] [092/132] (707s left) kms_psr (fbc-pr-basic)
[314.155520] Starting subtest: fbc-pr-basic
[314.160030] Subtest fbc-pr-basic: SKIP (0.000s)
[314.243110] [093/132] (707s left) kms_cursor_crc (cursor-onscreen-512x512)
[314.529519] Starting subtest: cursor-onscreen-512x512
[314.533808] Subtest cursor-onscreen-512x512: SKIP (0.001s)
[314.700120] [094/132] (707s left) gem_exec_schedule (u-submit-late-slice)
[314.773846] Starting subtest: u-submit-late-slice
[314.775779] Starting dynamic subtest: rcs0
[314.803808] Dynamic subtest rcs0: SUCCESS (0.036s)
[314.813631] Starting dynamic subtest: bcs0
[314.846861] Dynamic subtest bcs0: SUCCESS (0.042s)
[314.856216] Starting dynamic subtest: vcs0
[314.879695] Dynamic subtest vcs0: SUCCESS (0.032s)
[314.889905] Starting dynamic subtest: vcs1
[314.911764] Dynamic subtest vcs1: SUCCESS (0.031s)
[314.920805] Starting dynamic subtest: vecs0
[314.944411] Dynamic subtest vecs0: SUCCESS (0.031s)
[314.953948] Starting dynamic subtest: ccs0
[314.985792] Dynamic subtest ccs0: SUCCESS (0.041s)
[314.987629] Subtest u-submit-late-slice: SUCCESS (0.219s)
[316.882793] [095/132] (705s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-mmap-gtt)
[316.990538] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-mmap-gtt
[316.994996] Subtest fbc-1p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[317.118550] [096/132] (705s left) kms_cursor_legacy (cursora-vs-flipa-atomic-transitions)
[317.248768] Starting subtest: cursorA-vs-flipA-atomic-transitions
[328.402825] Subtest cursorA-vs-flipA-atomic-transitions: SUCCESS (11.150s)
[329.285369] [097/132] (692s left) syncobj_wait (invalid-signal-zero-handles)
[329.343623] Starting subtest: invalid-signal-zero-handles
[329.345725] Subtest invalid-signal-zero-handles: SUCCESS (0.000s)
[329.428196] [098/132] (692s left) kms_cursor_legacy (cursora-vs-flipb-atomic)
[329.549750] Starting subtest: cursorA-vs-flipB-atomic
[329.554048] Subtest cursorA-vs-flipB-atomic: SKIP (0.001s)
[329.692857] [099/132] (692s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-shrfb-draw-blt)
[329.785432] Starting subtest: fbc-1p-offscreen-pri-shrfb-draw-blt
[333.943861] Subtest fbc-1p-offscreen-pri-shrfb-draw-blt: SUCCESS (4.160s)
[335.081317] [100/132] (687s left) syncobj_timeline (invalid-multi-wait-unsubmitted-submitted-signaled)
[335.140758] Starting subtest: invalid-multi-wait-unsubmitted-submitted-signaled
[335.143118] Subtest invalid-multi-wait-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[335.234860] [101/132] (687s left) gem_softpin (evict-active)
[335.304260] Starting subtest: evict-active
[335.306235] Subtest evict-active: SUCCESS (0.006s)
[335.424988] [102/132] (686s left) syncobj_timeline (single-wait-for-submit-signaled)
[335.479805] Starting subtest: single-wait-for-submit-signaled
[335.482009] Subtest single-wait-for-submit-signaled: SUCCESS (0.000s)
[335.572272] [103/132] (686s left) kms_cursor_legacy (short-flip-after-cursor-toggle)
[335.692174] Starting subtest: short-flip-after-cursor-toggle
[336.612936] Subtest short-flip-after-cursor-toggle: SUCCESS (0.920s)
[337.413113] [104/132] (685s left) api_intel_bb (reset-bb)
[337.471499] Starting subtest: reset-bb
[337.473966] Subtest reset-bb: SUCCESS (0.004s)
[337.587842] [105/132] (684s left) kms_psr2_sf (fbc-psr2-overlay-primary-update-sf-dmg-area)
[337.692530] Starting subtest: fbc-psr2-overlay-primary-update-sf-dmg-area
[337.694884] Starting dynamic subtest: pipe-A-eDP-1
[337.811507] Dynamic subtest pipe-A-eDP-1: SKIP (0.123s)
[337.823743] Starting dynamic subtest: pipe-B-eDP-1
[338.994028] Dynamic subtest pipe-B-eDP-1: SKIP (1.180s)
[338.998291] Subtest fbc-psr2-overlay-primary-update-sf-dmg-area: SKIP (1.305s)
[340.190371] [106/132] (682s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-mmap-gtt)
[340.290928] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-mmap-gtt
[340.295080] Subtest psr-2p-scndscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[340.389679] [107/132] (682s left) syncobj_basic (bad-create-flags)
[340.439381] Starting subtest: bad-create-flags
[340.441644] Subtest bad-create-flags: SUCCESS (0.000s)
[340.553427] [108/132] (682s left) kms_getfb (getfb-handle-protection)
[340.642942] Starting subtest: getfb-handle-protection
[340.668653] Subtest getfb-handle-protection: SUCCESS (0.027s)
[340.795753] [109/132] (681s left) kms_flip (absolute-wf_vblank-interruptible)
[340.895940] Starting subtest: absolute-wf_vblank-interruptible
[340.898185] Starting dynamic subtest: A-eDP1
[349.639217] Dynamic subtest A-eDP1: SUCCESS (8.740s)
[349.650272] Starting dynamic subtest: B-eDP1
[358.360421] Dynamic subtest B-eDP1: SUCCESS (8.718s)
[358.371471] Starting dynamic subtest: C-eDP1
[367.077383] Dynamic subtest C-eDP1: SUCCESS (8.712s)
[367.086851] Starting dynamic subtest: D-eDP1
[375.811859] Dynamic subtest D-eDP1: SUCCESS (8.731s)
[375.816735] Subtest absolute-wf_vblank-interruptible: SUCCESS (34.911s)
[377.032898] [110/132] (645s left) gem_lmem_swapping (verify-random-ccs)
[377.089503] Subtest verify-random-ccs: SKIP (0.000s)
[377.139468] [111/132] (645s left) kms_big_fb (x-tiled-16bpp-rotate-90)
[377.233678] Starting subtest: x-tiled-16bpp-rotate-90
[377.257314] Subtest x-tiled-16bpp-rotate-90: SKIP (0.020s)
[377.381046] [112/132] (645s left) perf_pmu (busy-idle-check-all)
[377.428948] Starting subtest: busy-idle-check-all
[377.430874] Starting dynamic subtest: rcs0
[378.079813] Dynamic subtest rcs0: SUCCESS (0.652s)
[378.092167] Starting dynamic subtest: bcs0
[378.733271] Dynamic subtest bcs0: SUCCESS (0.651s)
[378.745694] Starting dynamic subtest: vcs0
[380.800932] Dynamic subtest vcs0: SUCCESS (2.063s)
[380.814474] Starting dynamic subtest: vcs1
[382.783996] Dynamic subtest vcs1: SUCCESS (1.980s)
[382.797327] Starting dynamic subtest: vecs0
[384.768533] Dynamic subtest vecs0: SUCCESS (1.981s)
[384.780924] Starting dynamic subtest: ccs0
[385.429773] Dynamic subtest ccs0: SUCCESS (0.660s)
[385.432339] Subtest busy-idle-check-all: SUCCESS (8.001s)
[385.532017] [113/132] (637s left) kms_async_flips (crc)
[385.639362] Starting subtest: crc
[386.022985] Starting dynamic subtest: pipe-A-eDP-1
[388.964004] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.941s)
[389.353162] Starting dynamic subtest: pipe-B-eDP-1
[392.294987] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.953s)
[392.711691] Starting dynamic subtest: pipe-C-eDP-1
[395.607388] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.920s)
[395.997384] Starting dynamic subtest: pipe-D-eDP-1
[398.861408] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.873s)
[398.863721] Subtest crc: SUCCESS (13.228s)
[400.030417] [114/132] (622s left) kms_color (ctm-negative)
[400.122700] Starting subtest: ctm-negative
[400.124625] Starting dynamic subtest: pipe-A-eDP-1
[400.835954] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.713s)
[400.846777] Starting dynamic subtest: pipe-B-eDP-1
[402.244932] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.408s)
[402.255192] Starting dynamic subtest: pipe-C-eDP-1
[403.598918] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.355s)
[403.609968] Starting dynamic subtest: pipe-D-eDP-1
[404.943453] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.343s)
[404.945818] Subtest ctm-negative: SUCCESS (4.823s)
[405.744310] [115/132] (617s left) kms_plane (pixel-format-yf-tiled-ccs-modifier-source-clamping)
[405.840550] Starting subtest: pixel-format-yf-tiled-ccs-modifier-source-clamping
[405.844983] Subtest pixel-format-yf-tiled-ccs-modifier-source-clamping: SKIP (0.000s)
[405.925592] [116/132] (617s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-onoff)
[406.017973] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-onoff
[406.022362] Subtest fbcpsr-2p-primscrn-spr-indfb-onoff: SKIP (0.000s)
[406.122022] [117/132] (616s left) kms_chamelium_frames (hdmi-cmp-planar-formats)
[406.504038] Subtest hdmi-cmp-planar-formats: SKIP (0.000s)
[407.352963] [118/132] (615s left) gem_lmem_swapping (heavy-verify-random)
[407.396790] Subtest heavy-verify-random: SKIP (0.000s)
[407.447978] [119/132] (615s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-mmap-wc)
[407.553102] Starting subtest: psr-2p-primscrn-spr-indfb-draw-mmap-wc
[407.557144] Subtest psr-2p-primscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[407.661048] [120/132] (615s left) gem_ccs (ctrl-surf-copy-new-ctx)
[407.715372] Starting subtest: ctrl-surf-copy-new-ctx
[407.719548] Subtest ctrl-surf-copy-new-ctx: SKIP (0.000s)
[407.809706] [121/132] (615s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-mmap-wc)
[407.902986] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-mmap-wc
[407.907076] Subtest fbc-2p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[408.013448] [122/132] (615s left) kms_vrr (max-min)
[408.108340] Starting subtest: max-min
[408.114935] Subtest max-min: SKIP (0.000s)
[408.180568] [123/132] (615s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-pwrite)
[408.284292] Starting subtest: psr-2p-primscrn-cur-indfb-draw-pwrite
[408.287929] Subtest psr-2p-primscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[408.380904] [124/132] (614s left) i915_drm_fdinfo (most-busy-check-all)
[408.420207] Starting subtest: most-busy-check-all
[408.422167] Starting dynamic subtest: rcs0
[408.428917] Dynamic subtest rcs0: SKIP (0.004s)
[408.445558] Starting dynamic subtest: bcs0
[408.449393] Dynamic subtest bcs0: SKIP (0.000s)
[408.459972] Starting dynamic subtest: vcs0
[408.463395] Dynamic subtest vcs0: SKIP (0.000s)
[408.472242] Starting dynamic subtest: vcs1
[408.475611] Dynamic subtest vcs1: SKIP (0.001s)
[408.484483] Starting dynamic subtest: vecs0
[408.487983] Dynamic subtest vecs0: SKIP (0.000s)
[408.496934] Starting dynamic subtest: ccs0
[408.500369] Dynamic subtest ccs0: SKIP (0.000s)
[408.503882] Subtest most-busy-check-all: SKIP (0.010s)
[408.540925] [125/132] (614s left) gem_pxp (create-valid-protected-context)
[408.669714] Starting subtest: create-valid-protected-context
[408.671739] Subtest create-valid-protected-context: SUCCESS (0.002s)
[408.774839] [126/132] (614s left) gem_ctx_param (vm)
[408.834022] Starting subtest: vm
[408.881975] Subtest vm: SUCCESS (0.047s)
[409.005589] [127/132] (614s left) syncobj_timeline (multi-wait-all-signaled)
[409.059447] Starting subtest: multi-wait-all-signaled
[409.061321] Subtest multi-wait-all-signaled: SUCCESS (0.000s)
[409.166014] [128/132] (614s left) kms_vblank (wait-forked-busy)
[409.257748] Starting subtest: wait-forked-busy
[409.259625] Starting dynamic subtest: pipe-A-eDP-1
[411.138242] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.881s)
[411.154088] Starting dynamic subtest: pipe-D-eDP-1
[413.736614] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.593s)
[413.738462] Subtest wait-forked-busy: SUCCESS (4.478s)
[414.539098] [129/132] (609s left) gem_exec_balancer (full)
[414.600186] Starting subtest: full
[419.626349] Subtest full: SUCCESS (5.026s)
[419.950195] [130/132] (603s left) gem_mmap_wc (copy)
[420.016578] Subtest copy: SKIP (0.000s)
[420.076218] [131/132] (603s left) gem_softpin (full)
[420.135997] Starting subtest: full
[420.150538] Subtest full: SUCCESS (0.015s)
[420.287060] [132/132] (603s left) kms_async_flips (crc-atomic)
[420.383555] Starting subtest: crc-atomic
[420.771047] Starting dynamic subtest: pipe-A-eDP-1
[423.650477] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.878s)
[424.045671] Starting dynamic subtest: pipe-B-eDP-1
[426.898016] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.866s)
[427.273730] Starting dynamic subtest: pipe-C-eDP-1
[430.231905] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.967s)
[430.604279] Starting dynamic subtest: pipe-D-eDP-1
[433.517933] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.927s)
[433.520314] Subtest crc-atomic: SUCCESS (13.138s)
[434.697812] Closing watchdogs
results: parsing output: 0/ for test: syncobj_basic
results: parsing output: 1/ for test: kms_plane_scaling
results: parsing output: 2/ for test: i915_pm_rps
results: parsing output: 3/ for test: kms_feature_discovery
results: parsing output: 4/ for test: gem_exec_reloc
results: parsing output: 5/ for test: kms_frontbuffer_tracking
results: parsing output: 6/ for test: kms_atomic_interruptible
results: parsing output: 7/ for test: kms_psr
results: parsing output: 8/ for test: kms_big_fb
results: parsing output: 9/ for test: gem_exec_fence
results: parsing output: 10/ for test: kms_flip_scaled_crc
results: parsing output: 11/ for test: prime_mmap
results: parsing output: 12/ for test: syncobj_timeline
results: parsing output: 13/ for test: gem_eio
results: parsing output: 14/ for test: kms_frontbuffer_tracking
results: parsing output: 15/ for test: kms_ccs
results: parsing output: 16/ for test: gem_exec_reloc
results: parsing output: 17/ for test: kms_flip
results: parsing output: 18/ for test: gem_pread
results: parsing output: 19/ for test: kms_big_fb
results: parsing output: 20/ for test: gem_exec_schedule
results: parsing output: 21/ for test: i915_pm_rps
results: parsing output: 22/ for test: kms_lease
results: parsing output: 23/ for test: gem_pxp
results: parsing output: 24/ for test: drm_mm
results: parsing output: 25/ for test: gem_exec_params
results: parsing output: 26/ for test: perf
results: parsing output: 27/ for test: kms_ccs
results: parsing output: 28/ for test: kms_dirtyfb
results: parsing output: 29/ for test: kms_frontbuffer_tracking
results: parsing output: 30/ for test: kms_pipe_crc_basic
results: parsing output: 31/ for test: kms_psr
results: parsing output: 32/ for test: kms_plane_scaling
results: parsing output: 33/ for test: gen7_exec_parse
results: parsing output: 34/ for test: kms_atomic_transition
results: parsing output: 35/ for test: kms_psr
results: parsing output: 36/ for test: gem_softpin
results: parsing output: 37/ for test: kms_content_protection
results: parsing output: 38/ for test: syncobj_eventfd
results: parsing output: 39/ for test: syncobj_timeline
results: parsing output: 40/ for test: kms_frontbuffer_tracking
results: parsing output: 41/ for test: kms_big_fb
results: parsing output: 42/ for test: kms_flip
results: parsing output: 43/ for test: kms_flip_scaled_crc
results: parsing output: 44/ for test: kms_chamelium_audio
results: parsing output: 45/ for test: kms_frontbuffer_tracking
results: parsing output: 46/ for test: syncobj_wait
results: parsing output: 47/ for test: gem_exec_parallel
results: parsing output: 48/ for test: kms_cursor_legacy
results: parsing output: 49/ for test: gem_ctx_sseu
results: parsing output: 50/ for test: kms_cursor_legacy
results: parsing output: 51/ for test: kms_flip
results: parsing output: 52/ for test: kms_ccs
results: parsing output: 53/ for test: kms_psr
results: parsing output: 54/ for test: gem_exec_schedule
results: parsing output: 55/ for test: kms_big_fb
results: parsing output: 56/ for test: kms_getfb
results: parsing output: 57/ for test: gem_eio
results: parsing output: 58/ for test: prime_vgem
results: parsing output: 59/ for test: gem_exec_flush
results: parsing output: 60/ for test: kms_frontbuffer_tracking
results: parsing output: 61/ for test: kms_properties
results: parsing output: 62/ for test: kms_psr
results: parsing output: 63/ for test: kms_plane
results: parsing output: 64/ for test: kms_ccs
results: parsing output: 65/ for test: kms_invalid_mode
results: parsing output: 66/ for test: i915_hangman
results: parsing output: 67/ for test: gem_render_copy
results: parsing output: 68/ for test: kms_frontbuffer_tracking
results: parsing output: 69/ for test: kms_cursor_edge_walk
results: parsing output: 70/ for test: kms_pm_rpm
results: parsing output: 71/ for test: kms_pm_rpm
results: parsing output: 72/ for test: api_intel_bb
results: parsing output: 73/ for test: kms_big_fb
results: parsing output: 74/ for test: kms_frontbuffer_tracking
results: parsing output: 75/ for test: kms_frontbuffer_tracking
results: parsing output: 76/ for test: kms_universal_plane
results: parsing output: 77/ for test: gem_mmap_offset
results: parsing output: 78/ for test: kms_cursor_crc
results: parsing output: 79/ for test: gem_cs_tlb
results: parsing output: 80/ for test: kms_flip
results: parsing output: 81/ for test: kms_frontbuffer_tracking
results: parsing output: 82/ for test: gem_userptr_blits
results: parsing output: 83/ for test: gem_ctx_bad_destroy
results: parsing output: 84/ for test: kms_chamelium_hpd
results: parsing output: 85/ for test: gem_ctx_persistence
results: parsing output: 86/ for test: perf
results: parsing output: 87/ for test: gem_exec_fence
results: parsing output: 88/ for test: kms_big_fb
results: parsing output: 89/ for test: syncobj_wait
results: parsing output: 90/ for test: kms_frontbuffer_tracking
results: parsing output: 91/ for test: kms_psr
results: parsing output: 92/ for test: kms_cursor_crc
results: parsing output: 93/ for test: gem_exec_schedule
results: parsing output: 94/ for test: kms_frontbuffer_tracking
results: parsing output: 95/ for test: kms_cursor_legacy
results: parsing output: 96/ for test: syncobj_wait
results: parsing output: 97/ for test: kms_cursor_legacy
results: parsing output: 98/ for test: kms_frontbuffer_tracking
results: parsing output: 99/ for test: syncobj_timeline
results: parsing output: 100/ for test: gem_softpin
results: parsing output: 101/ for test: syncobj_timeline
results: parsing output: 102/ for test: kms_cursor_legacy
results: parsing output: 103/ for test: api_intel_bb
results: parsing output: 104/ for test: kms_psr2_sf
results: parsing output: 105/ for test: kms_frontbuffer_tracking
results: parsing output: 106/ for test: syncobj_basic
results: parsing output: 107/ for test: kms_getfb
results: parsing output: 108/ for test: kms_flip
results: parsing output: 109/ for test: gem_lmem_swapping
results: parsing output: 110/ for test: kms_big_fb
results: parsing output: 111/ for test: perf_pmu
results: parsing output: 112/ for test: kms_async_flips
results: parsing output: 113/ for test: kms_color
results: parsing output: 114/ for test: kms_plane
results: parsing output: 115/ for test: kms_frontbuffer_tracking
results: parsing output: 116/ for test: kms_chamelium_frames
results: parsing output: 117/ for test: gem_lmem_swapping
results: parsing output: 118/ for test: kms_frontbuffer_tracking
results: parsing output: 119/ for test: gem_ccs
results: parsing output: 120/ for test: kms_frontbuffer_tracking
results: parsing output: 121/ for test: kms_vrr
results: parsing output: 122/ for test: kms_frontbuffer_tracking
results: parsing output: 123/ for test: i915_drm_fdinfo
results: parsing output: 124/ for test: gem_pxp
results: parsing output: 125/ for test: gem_ctx_param
results: parsing output: 126/ for test: syncobj_timeline
results: parsing output: 127/ for test: kms_vblank
results: parsing output: 128/ for test: gem_exec_balancer
results: parsing output: 129/ for test: gem_mmap_wc
results: parsing output: 130/ for test: gem_softpin
results: parsing output: 131/ for test: kms_async_flips
Done.