[54.494571] Initializing watchdogs
[54.494618]   /dev/watchdog0
[54.509357] [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]
[54.513965] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[54.516298] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[54.519454] [001/131] (960s left) core_getclient
[54.666763] [002/131] (960s left) kms_draw_crc (draw-method-mmap-cpu)
[54.773513] Starting subtest: draw-method-mmap-cpu
[54.775560] Starting dynamic subtest: xrgb8888-untiled
[54.999968] Dynamic subtest xrgb8888-untiled: SUCCESS (0.233s)
[55.006081] Starting dynamic subtest: rgb565-untiled
[55.205964] Dynamic subtest rgb565-untiled: SUCCESS (0.211s)
[55.212334] Starting dynamic subtest: xrgb2101010-untiled
[55.412347] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.211s)
[55.420739] Starting dynamic subtest: xbgr16161616f-untiled
[55.619507] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.211s)
[55.626181] Starting dynamic subtest: xrgb8888-xtiled
[55.749640] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.133s)
[55.756063] Starting dynamic subtest: rgb565-xtiled
[55.868839] Dynamic subtest rgb565-xtiled: SUCCESS (0.122s)
[55.875124] Starting dynamic subtest: xrgb2101010-xtiled
[55.977632] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.111s)
[55.984046] Starting dynamic subtest: xbgr16161616f-xtiled
[56.097585] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (0.122s)
[56.107021] Starting dynamic subtest: xrgb8888-4tiled
[56.239046] Dynamic subtest xrgb8888-4tiled: SUCCESS (0.144s)
[56.245615] Starting dynamic subtest: rgb565-4tiled
[56.369965] Dynamic subtest rgb565-4tiled: SUCCESS (0.133s)
[56.376347] Starting dynamic subtest: xrgb2101010-4tiled
[56.478669] Dynamic subtest xrgb2101010-4tiled: SUCCESS (0.111s)
[56.485192] Starting dynamic subtest: xbgr16161616f-4tiled
[56.609490] Dynamic subtest xbgr16161616f-4tiled: SUCCESS (0.133s)
[56.611320] Subtest draw-method-mmap-cpu: SUCCESS (1.878s)
[56.707433] [003/131] (958s left) syncobj_timeline (etime-multi-wait-all-available-unsubmitted-submitted-signal
[56.765521] Starting subtest: etime-multi-wait-all-available-unsubmitted-submitted-signaled
[56.871940] Subtest etime-multi-wait-all-available-unsubmitted-submitted-signaled: SUCCESS (0.107s)
[56.942184] [004/131] (958s left) kms_big_fb (linear-32bpp-rotate-270)
[57.048879] Starting subtest: linear-32bpp-rotate-270
[57.067639] Subtest linear-32bpp-rotate-270: SKIP (0.019s)
[57.176892] [005/131] (957s left) gem_userptr_blits (sd-probe)
[57.239340] Starting subtest: sd-probe
[57.241307] Subtest sd-probe: SUCCESS (0.000s)
[57.358366] [006/131] (957s left) kms_plane_scaling (plane-upscale-factor-0-25-with-rotation)
[57.447041] Starting subtest: plane-upscale-factor-0-25-with-rotation
[57.449406] Starting dynamic subtest: pipe-A
[57.670196] Dynamic subtest pipe-A: SUCCESS (0.227s)
[57.678080] Starting dynamic subtest: pipe-B
[58.945535] Dynamic subtest pipe-B: SUCCESS (1.295s)
[58.953948] Starting dynamic subtest: pipe-C
[60.250353] Dynamic subtest pipe-C: SUCCESS (1.321s)
[60.258967] Starting dynamic subtest: pipe-D
[61.563092] Dynamic subtest pipe-D: SUCCESS (1.327s)
[61.565341] Subtest plane-upscale-factor-0-25-with-rotation: SUCCESS (4.171s)
[62.715691] [007/131] (952s left) kms_async_flips (basic-modeset-with-all-modifiers-formats)
[62.803256] Starting subtest: basic-modeset-with-all-modifiers-formats
[63.172650] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-XRGB8888
[63.984366] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-XRGB8888: SUCCESS (0.819s)
[63.991175] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-XRGB2101010
[64.006449] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-XRGB2101010: SUCCESS (0.022s)
[64.015427] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-XRGB16161616F
[64.028293] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-XRGB16161616F: SUCCESS (0.022s)
[64.035709] Starting dynamic subtest: pipe-A-eDP-1-4-RGB565
[64.183104] Dynamic subtest pipe-A-eDP-1-4-RGB565: SUCCESS (0.156s)
[64.190070] Starting dynamic subtest: pipe-A-eDP-1-4-XRGB8888
[64.205267] Dynamic subtest pipe-A-eDP-1-4-XRGB8888: SUCCESS (0.022s)
[64.212142] Starting dynamic subtest: pipe-A-eDP-1-4-XRGB2101010
[64.227200] Dynamic subtest pipe-A-eDP-1-4-XRGB2101010: SUCCESS (0.022s)
[64.233972] Starting dynamic subtest: pipe-A-eDP-1-4-XRGB16161616F
[64.249859] Dynamic subtest pipe-A-eDP-1-4-XRGB16161616F: SUCCESS (0.022s)
[64.259653] Starting dynamic subtest: pipe-A-eDP-1-4-YUYV
[64.271494] Dynamic subtest pipe-A-eDP-1-4-YUYV: SUCCESS (0.022s)
[64.278475] Starting dynamic subtest: pipe-A-eDP-1-4-Y210
[64.293221] Dynamic subtest pipe-A-eDP-1-4-Y210: SUCCESS (0.022s)
[64.299894] Starting dynamic subtest: pipe-A-eDP-1-4-XYUV8888
[64.315325] Dynamic subtest pipe-A-eDP-1-4-XYUV8888: SUCCESS (0.022s)
[64.322113] Starting dynamic subtest: pipe-A-eDP-1-4-XV30
[64.337826] Dynamic subtest pipe-A-eDP-1-4-XV30: SUCCESS (0.022s)
[64.349528] Starting dynamic subtest: pipe-A-eDP-1-4-XV36
[64.359476] Dynamic subtest pipe-A-eDP-1-4-XV36: SUCCESS (0.022s)
[64.366715] Starting dynamic subtest: pipe-A-eDP-1-x-RGB565
[64.514161] Dynamic subtest pipe-A-eDP-1-x-RGB565: SUCCESS (0.155s)
[64.522140] Starting dynamic subtest: pipe-A-eDP-1-x-XRGB8888
[64.536460] Dynamic subtest pipe-A-eDP-1-x-XRGB8888: SUCCESS (0.022s)
[64.543574] Starting dynamic subtest: pipe-A-eDP-1-x-XRGB2101010
[64.558191] Dynamic subtest pipe-A-eDP-1-x-XRGB2101010: SUCCESS (0.022s)
[64.565547] Starting dynamic subtest: pipe-A-eDP-1-x-XRGB16161616F
[64.580110] Dynamic subtest pipe-A-eDP-1-x-XRGB16161616F: SUCCESS (0.022s)
[64.587148] Starting dynamic subtest: pipe-A-eDP-1-x-YUYV
[64.602232] Dynamic subtest pipe-A-eDP-1-x-YUYV: SUCCESS (0.022s)
[64.609275] Starting dynamic subtest: pipe-A-eDP-1-x-Y210
[64.624446] Dynamic subtest pipe-A-eDP-1-x-Y210: SUCCESS (0.022s)
[64.632583] Starting dynamic subtest: pipe-A-eDP-1-x-XYUV8888
[64.646585] Dynamic subtest pipe-A-eDP-1-x-XYUV8888: SUCCESS (0.022s)
[64.655516] Starting dynamic subtest: pipe-A-eDP-1-x-XV30
[64.668578] Dynamic subtest pipe-A-eDP-1-x-XV30: SUCCESS (0.022s)
[64.675414] Starting dynamic subtest: pipe-A-eDP-1-x-XV36
[64.690462] Dynamic subtest pipe-A-eDP-1-x-XV36: SUCCESS (0.022s)
[64.698525] Starting dynamic subtest: pipe-A-eDP-1-linear-RGB565
[64.845175] Dynamic subtest pipe-A-eDP-1-linear-RGB565: SUCCESS (0.156s)
[64.851894] Starting dynamic subtest: pipe-A-eDP-1-linear-XRGB8888
[64.867334] Dynamic subtest pipe-A-eDP-1-linear-XRGB8888: SUCCESS (0.022s)
[64.875040] Starting dynamic subtest: pipe-A-eDP-1-linear-XRGB2101010
[64.889486] Dynamic subtest pipe-A-eDP-1-linear-XRGB2101010: SUCCESS (0.022s)
[64.898079] Starting dynamic subtest: pipe-A-eDP-1-linear-XRGB16161616F
[64.911905] Dynamic subtest pipe-A-eDP-1-linear-XRGB16161616F: SUCCESS (0.022s)
[64.923593] Starting dynamic subtest: pipe-A-eDP-1-linear-YUYV
[64.933677] Dynamic subtest pipe-A-eDP-1-linear-YUYV: SUCCESS (0.022s)
[64.943485] Starting dynamic subtest: pipe-A-eDP-1-linear-Y210
[64.955886] Dynamic subtest pipe-A-eDP-1-linear-Y210: SUCCESS (0.022s)
[64.964387] Starting dynamic subtest: pipe-A-eDP-1-linear-XYUV8888
[64.978358] Dynamic subtest pipe-A-eDP-1-linear-XYUV8888: SUCCESS (0.022s)
[64.988971] Starting dynamic subtest: pipe-A-eDP-1-linear-XV30
[65.000154] Dynamic subtest pipe-A-eDP-1-linear-XV30: SUCCESS (0.022s)
[65.009615] Starting dynamic subtest: pipe-A-eDP-1-linear-XV36
[65.021670] Dynamic subtest pipe-A-eDP-1-linear-XV36: SUCCESS (0.022s)
[65.400203] Subtest basic-modeset-with-all-modifiers-formats: SUCCESS (2.614s)
[66.241098] [008/131] (949s left) gem_softpin (evict-snoop)
[66.296501] Starting subtest: evict-snoop
[66.301207] Subtest evict-snoop: SKIP (0.000s)
[66.408203] [009/131] (948s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-0-async-flip)
[66.504756] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-0-async-flip
[67.159161] Subtest 4-tiled-max-hw-stride-32bpp-rotate-0-async-flip: SUCCESS (0.659s)
[67.313902] [010/131] (948s left) kms_psr2_sf (fbc-pr-primary-plane-update-sf-dmg-area)
[72.276985] Starting subtest: fbc-pr-primary-plane-update-sf-dmg-area
[72.281960] Subtest fbc-pr-primary-plane-update-sf-dmg-area: SKIP (0.005s)
[73.137270] [011/131] (942s left) kms_panel_fitting (atomic-fastset)
[73.230984] Starting subtest: atomic-fastset
[73.233408] Starting dynamic subtest: pipe-A-eDP-1
[73.394897] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.164s)
[73.405286] Starting dynamic subtest: pipe-B-eDP-1
[74.575689] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.182s)
[74.585055] Starting dynamic subtest: pipe-C-eDP-1
[75.758037] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.183s)
[75.766876] Starting dynamic subtest: pipe-D-eDP-1
[76.886859] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.130s)
[76.889253] Subtest atomic-fastset: SUCCESS (3.661s)
[78.119877] [012/131] (937s left) gem_mmap_wc (invalid-flags)
[78.177325] Subtest invalid-flags: SKIP (0.000s)
[78.239204] [013/131] (937s left) kms_plane (plane-panning-bottom-right-suspend)
[78.330074] Starting subtest: plane-panning-bottom-right-suspend
[78.332398] Starting dynamic subtest: pipe-A
[96.792769] Dynamic subtest pipe-A: SUCCESS (2.886s)
[96.801206] Starting dynamic subtest: pipe-B
[114.734562] Dynamic subtest pipe-B: SUCCESS (3.448s)
[114.736853] Subtest plane-panning-bottom-right-suspend: SUCCESS (6.336s)
[115.534826] [014/131] (899s left) kms_psr2_sf (psr2-cursor-plane-update-sf)
[120.468315] Starting subtest: psr2-cursor-plane-update-sf
[120.470606] Starting dynamic subtest: pipe-A-eDP-1
[121.753239] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.307s)
[121.762878] Starting dynamic subtest: pipe-B-eDP-1
[123.063381] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.325s)
[123.065677] Subtest psr2-cursor-plane-update-sf: SUCCESS (2.635s)
[123.915354] [015/131] (891s left) kms_ccs (bad-pixel-format-4-tiled-mtl-mc-ccs)
[124.010941] Starting subtest: bad-pixel-format-4-tiled-mtl-mc-ccs
[124.013365] Starting dynamic subtest: pipe-A-eDP-1
[124.034757] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[124.048343] Starting dynamic subtest: pipe-B-eDP-1
[124.068437] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[124.076145] Starting dynamic subtest: pipe-C-eDP-1
[124.095368] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[124.103008] Starting dynamic subtest: pipe-D-eDP-1
[124.121678] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[124.123791] Subtest bad-pixel-format-4-tiled-mtl-mc-ccs: SUCCESS (0.006s)
[126.147710] [016/131] (889s left) syncobj_basic (bad-flags-handle-to-fd)
[126.193795] Starting subtest: bad-flags-handle-to-fd
[126.196078] Subtest bad-flags-handle-to-fd: SUCCESS (0.000s)
[126.296798] [017/131] (889s left) gem_userptr_blits (invalid-null-pointer)
[126.355263] Starting subtest: invalid-null-pointer
[126.357528] Subtest invalid-null-pointer: SUCCESS (0.001s)
[126.502996] [018/131] (889s left) gem_ctx_persistence (engines-queued)
[126.556859] Starting subtest: engines-queued
[126.559117] Starting dynamic subtest: rcs0
[126.667221] Dynamic subtest rcs0: SUCCESS (0.111s)
[126.678395] Starting dynamic subtest: bcs0
[126.731205] Dynamic subtest bcs0: SUCCESS (0.064s)
[126.740911] Starting dynamic subtest: vcs0
[128.092222] Dynamic subtest vcs0: SUCCESS (1.368s)
[128.102570] Starting dynamic subtest: vcs1
[130.074657] Dynamic subtest vcs1: SUCCESS (1.994s)
[130.085480] Starting dynamic subtest: vecs0
[132.059368] Dynamic subtest vecs0: SUCCESS (1.993s)
[132.067632] Starting dynamic subtest: ccs0
[132.283215] Dynamic subtest ccs0: SUCCESS (0.226s)
[132.285605] Subtest engines-queued: SUCCESS (5.762s)
[132.361574] [019/131] (883s left) kms_flip (flip-vs-dpms-on-nop-interruptible)
[132.479500] Starting subtest: flip-vs-dpms-on-nop-interruptible
[132.481955] Starting dynamic subtest: A-eDP1
[134.296663] Dynamic subtest A-eDP1: SUCCESS (1.823s)
[134.307211] Starting dynamic subtest: B-eDP1
[136.112961] Dynamic subtest B-eDP1: SUCCESS (1.821s)
[136.122117] Starting dynamic subtest: C-eDP1
[137.921942] Dynamic subtest C-eDP1: SUCCESS (1.813s)
[137.930292] Starting dynamic subtest: D-eDP1
[139.748353] Dynamic subtest D-eDP1: SUCCESS (1.829s)
[139.753050] Subtest flip-vs-dpms-on-nop-interruptible: SUCCESS (7.296s)
[140.900571] [020/131] (874s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-blt)
[141.010931] Starting subtest: psr-2p-primscrn-pri-indfb-draw-blt
[141.015384] Subtest psr-2p-primscrn-pri-indfb-draw-blt: SKIP (0.000s)
[141.129839] [021/131] (874s left) gen9_exec_parse (cmd-crossing-page)
[141.195868] Subtest cmd-crossing-page: SKIP (0.000s)
[141.279126] [022/131] (874s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-mmap-wc)
[141.370698] Starting subtest: psr-2p-primscrn-spr-indfb-draw-mmap-wc
[141.374777] Subtest psr-2p-primscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[141.465010] [023/131] (874s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-mmap-wc)
[141.571136] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-mmap-wc
[148.592041] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-mmap-wc: SUCCESS (7.033s)
[148.726739] [024/131] (867s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-pwrite)
[148.823738] Starting subtest: fbcpsr-rgb101010-draw-pwrite
[155.769567] Subtest fbcpsr-rgb101010-draw-pwrite: SUCCESS (6.951s)
[155.898771] [025/131] (860s left) gem_exec_fence (syncobj-repeat)
[156.350700] Starting subtest: syncobj-repeat
[156.526101] Subtest syncobj-repeat: SUCCESS (0.174s)
[158.141962] [FACT gem_exec_fence (syncobj-repeat)] new: kernel.kmod_is_loaded.vgem: true
[158.145667] [026/131] (857s left) kms_ccs (bad-rotation-90-y-tiled-gen12-mc-ccs)
[158.231699] Starting subtest: bad-rotation-90-y-tiled-gen12-mc-ccs
[158.233983] Starting dynamic subtest: pipe-A-eDP-1
[158.256827] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[158.265268] Starting dynamic subtest: pipe-B-eDP-1
[158.286928] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[158.295348] Starting dynamic subtest: pipe-C-eDP-1
[158.316913] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[158.325189] Starting dynamic subtest: pipe-D-eDP-1
[158.347530] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[158.351767] Subtest bad-rotation-90-y-tiled-gen12-mc-ccs: SKIP (0.004s)
[160.435940] [027/131] (855s left) perf (polling-parameterized)
[160.542454] Starting subtest: polling-parameterized
[180.562712] Subtest polling-parameterized: SUCCESS (20.031s)
[180.613505] [028/131] (835s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-pwrite)
[180.719913] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-pwrite
[180.724302] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[180.832816] [029/131] (835s left) gem_mmap_gtt (cpuset-medium-copy-odd)
[180.889708] Subtest cpuset-medium-copy-odd: SKIP (0.000s)
[180.950940] [030/131] (835s left) i915_hangman (hangcheck-unterminated)
[181.014277] Starting subtest: hangcheck-unterminated
[192.093397] Subtest hangcheck-unterminated: SUCCESS (11.085s)
[192.244946] [031/131] (823s left) kms_frontbuffer_tracking (fbc-tiling-linear)
[192.346777] Starting subtest: fbc-tiling-linear
[196.068483] Subtest fbc-tiling-linear: SUCCESS (3.727s)
[197.203593] [032/131] (818s left) gem_exec_whisper (basic-normal-all)
[197.260355] Starting subtest: basic-normal-all
[199.630117] Subtest basic-normal-all: SUCCESS (2.372s)
[199.811007] [033/131] (816s left) gem_ccs (block-multicopy-inplace)
[199.865049] Starting subtest: block-multicopy-inplace
[199.869391] Subtest block-multicopy-inplace: SKIP (0.000s)
[199.986517] [034/131] (816s left) kms_psr (psr-suspend)
[200.084958] Starting subtest: psr-suspend
[200.087245] Starting dynamic subtest: eDP-1
[217.846888] Dynamic subtest eDP-1: SUCCESS (2.920s)
[217.849181] Subtest psr-suspend: SUCCESS (2.921s)
[218.667310] [035/131] (797s left) gem_exec_reloc (basic-write-cpu-noreloc)
[218.724667] Subtest basic-write-cpu-noreloc: SKIP (0.000s)
[218.782563] [036/131] (797s left) kms_prop_blob (invalid-get-prop-any)
[218.843036] Starting subtest: invalid-get-prop-any
[218.845183] Subtest invalid-get-prop-any: SUCCESS (0.000s)
[218.923795] [037/131] (797s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-mmap-wc)
[219.027136] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-mmap-wc
[219.031191] Subtest fbc-2p-scndscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[219.141732] [038/131] (797s left) kms_big_fb (y-tiled-64bpp-rotate-180)
[219.252334] Starting subtest: y-tiled-64bpp-rotate-180
[219.256327] Subtest y-tiled-64bpp-rotate-180: SKIP (0.000s)
[219.346024] [039/131] (797s left) kms_invalid_mode (bad-vsync-start)
[219.441383] Starting subtest: bad-vsync-start
[219.443470] Starting dynamic subtest: pipe-A-eDP-1
[219.723811] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.293s)
[219.733410] Starting dynamic subtest: pipe-B-eDP-1
[219.735574] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[219.743636] Starting dynamic subtest: pipe-C-eDP-1
[219.745795] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[219.753407] Starting dynamic subtest: pipe-D-eDP-1
[219.755440] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[219.757395] Subtest bad-vsync-start: SUCCESS (0.299s)
[220.527570] [040/131] (795s left) i915_drm_fdinfo (memory-info-active)
[220.564857] Starting subtest: memory-info-active
[220.567125] Starting dynamic subtest: smem0
[223.133850] Dynamic subtest smem0: SUCCESS (2.637s)
[223.135922] Subtest memory-info-active: SUCCESS (2.637s)
[223.205597] [041/131] (793s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-mmap-wc)
[223.298395] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-mmap-wc
[223.301919] Subtest fbc-2p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[223.399319] [042/131] (793s left) kms_flip (wf_vblank-ts-check-interruptible)
[223.489356] Starting subtest: wf_vblank-ts-check-interruptible
[223.490933] Starting dynamic subtest: A-eDP1
[244.165014] Dynamic subtest A-eDP1: SUCCESS (20.827s)
[244.173884] Starting dynamic subtest: B-eDP1
[253.088083] Dynamic subtest B-eDP1: SUCCESS (8.928s)
[253.097973] Starting dynamic subtest: C-eDP1
[262.002054] Dynamic subtest C-eDP1: SUCCESS (8.908s)
[262.010910] Starting dynamic subtest: D-eDP1
[270.926149] Dynamic subtest D-eDP1: SUCCESS (8.922s)
[270.928618] Subtest wf_vblank-ts-check-interruptible: SUCCESS (47.593s)
[272.141570] [043/131] (744s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-mmap-cpu)
[272.251776] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-mmap-cpu
[272.255713] Subtest psr-2p-scndscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[272.358918] [044/131] (744s left) kms_chamelium_hpd (dp-hpd-enable-disable-mode)
[272.748556] Subtest dp-hpd-enable-disable-mode: SKIP (0.000s)
[273.554290] [045/131] (743s left) kms_cursor_legacy (single-move)
[273.674540] Starting subtest: single-move
[273.677207] Starting dynamic subtest: pipe-A
[279.058373] Dynamic subtest pipe-A: SUCCESS (5.381s)
[279.069033] Starting dynamic subtest: pipe-B
[284.442937] Dynamic subtest pipe-B: SUCCESS (5.382s)
[284.453086] Starting dynamic subtest: pipe-C
[289.825100] Dynamic subtest pipe-C: SUCCESS (5.382s)
[289.835475] Starting dynamic subtest: pipe-D
[295.206061] Dynamic subtest pipe-D: SUCCESS (5.380s)
[295.217083] Starting dynamic subtest: all-pipes
[300.592924] Dynamic subtest all-pipes: SUCCESS (5.387s)
[300.595472] Subtest single-move: SUCCESS (26.922s)
[300.736996] [046/131] (715s left) gem_exec_balancer (nop)
[300.800909] Starting subtest: nop
[347.388116] Subtest nop: SUCCESS (46.583s)
[347.691493] [047/131] (669s left) gem_fence_thrash (bo-write-verify-threaded-none)
[347.724215] Starting subtest: bo-write-verify-threaded-none
[347.742732] Subtest bo-write-verify-threaded-none: SKIP (0.017s)
[347.808790] [048/131] (669s left) kms_atomic_transition (plane-primary-toggle-with-vblank-wait)
[347.899878] Starting subtest: plane-primary-toggle-with-vblank-wait
[347.902164] Starting dynamic subtest: pipe-A-eDP-1
[348.076162] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.175s)
[348.383561] Starting dynamic subtest: pipe-B-eDP-1
[349.249053] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.876s)
[349.558308] Subtest plane-primary-toggle-with-vblank-wait: SUCCESS (1.657s)
[350.405231] [049/131] (666s left) gem_pxp (dmabuf-shared-protected-dst-is-context-refcounted)
[350.528419] Starting subtest: dmabuf-shared-protected-dst-is-context-refcounted
[350.657383] Subtest dmabuf-shared-protected-dst-is-context-refcounted: SUCCESS (0.132s)
[350.801812] [050/131] (666s left) perf_pmu (busy-double-start)
[350.840002] Starting subtest: busy-double-start
[350.842319] Starting dynamic subtest: rcs0
[354.475904] Dynamic subtest rcs0: FAIL (3.578s)
[354.486885] Starting dynamic subtest: bcs0
[357.993280] Dynamic subtest bcs0: SUCCESS (3.575s)
[358.004540] Starting dynamic subtest: vcs0
[362.465650] Dynamic subtest vcs0: SUCCESS (4.471s)
[362.477475] Starting dynamic subtest: vcs1
[366.457330] Dynamic subtest vcs1: SUCCESS (3.991s)
[366.469229] Starting dynamic subtest: vecs0
[370.419294] Dynamic subtest vecs0: SUCCESS (3.961s)
[370.429297] Starting dynamic subtest: ccs0
[374.055492] Dynamic subtest ccs0: FAIL (3.565s)
[374.057564] Subtest busy-double-start: FAIL (23.148s)
[374.101870] [051/131] (642s left) kms_flip (flip-vs-dpms-off-vs-modeset-interruptible)
[374.220676] Starting subtest: flip-vs-dpms-off-vs-modeset-interruptible
[374.222969] Starting dynamic subtest: A-eDP1
[377.810330] Dynamic subtest A-eDP1: SUCCESS (3.588s)
[377.820787] Starting dynamic subtest: B-eDP1
[380.973739] Dynamic subtest B-eDP1: SUCCESS (3.163s)
[380.983115] Starting dynamic subtest: C-eDP1
[384.043235] Dynamic subtest C-eDP1: SUCCESS (3.069s)
[384.053928] Starting dynamic subtest: D-eDP1
[387.125814] Dynamic subtest D-eDP1: SUCCESS (3.081s)
[387.128255] Subtest flip-vs-dpms-off-vs-modeset-interruptible: SUCCESS (12.909s)
[387.919497] [052/131] (629s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-0)
[388.025155] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-0
[389.014671] Subtest x-tiled-max-hw-stride-32bpp-rotate-0: SUCCESS (0.989s)
[389.134669] [053/131] (627s left) kms_color (ctm-signed)
[389.226942] Starting subtest: ctm-signed
[389.229165] Starting dynamic subtest: pipe-A-eDP-1
[391.262287] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.033s)
[391.273548] Starting dynamic subtest: pipe-B-eDP-1
[394.013033] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.752s)
[394.022508] Starting dynamic subtest: pipe-C-eDP-1
[396.589011] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.574s)
[396.599873] Starting dynamic subtest: pipe-D-eDP-1
[399.251477] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.663s)
[399.253838] Subtest ctm-signed: SUCCESS (10.025s)
[400.106244] [054/131] (616s left) gem_render_copy_redux (interruptible)
[400.169240] Starting subtest: interruptible
[400.429593] Subtest interruptible: SUCCESS (0.261s)
[400.566597] [055/131] (616s left) syncobj_timeline (single-wait-all-signaled)
[400.625642] Starting subtest: single-wait-all-signaled
[400.627833] Subtest single-wait-all-signaled: SUCCESS (0.001s)
[400.724322] [056/131] (616s left) kms_cursor_legacy (cursora-vs-flipb-atomic)
[400.847234] Starting subtest: cursorA-vs-flipB-atomic
[400.851860] Subtest cursorA-vs-flipB-atomic: SKIP (0.001s)
[401.004669] [057/131] (616s left) syncobj_wait (reset-signaled)
[401.061317] Starting subtest: reset-signaled
[401.063309] Subtest reset-signaled: SUCCESS (0.000s)
[401.160046] [058/131] (616s left) kms_sequence (get-forked-busy)
[401.247138] Starting subtest: get-forked-busy
[401.249176] Starting dynamic subtest: pipe-A-eDP-1
[403.181275] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.932s)
[403.191653] Starting dynamic subtest: pipe-B-eDP-1
[405.784303] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.602s)
[405.795430] Starting dynamic subtest: pipe-C-eDP-1
[408.398109] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.613s)
[408.408920] Starting dynamic subtest: pipe-D-eDP-1
[410.931770] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.534s)
[410.934175] Subtest get-forked-busy: SUCCESS (9.685s)
[411.710959] [059/131] (605s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-pwrite)
[411.823189] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-pwrite
[411.827376] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[411.917498] [060/131] (605s left) syncobj_timeline (multi-wait-all-available-submitted)
[411.972444] Starting subtest: multi-wait-all-available-submitted
[411.974671] Subtest multi-wait-all-available-submitted: SUCCESS (0.000s)
[412.069821] [061/131] (605s left) kms_flip (nonblocking-read)
[412.167786] Starting subtest: nonblocking-read
[412.170002] Subtest nonblocking-read: SUCCESS (0.000s)
[412.306434] [062/131] (605s left) gem_fence_thrash (bo-copy)
[412.340543] Starting subtest: bo-copy
[412.369468] Subtest bo-copy: SKIP (0.024s)
[412.443106] [063/131] (605s left) kms_flip_scaled_crc (flip-64bpp-xtile-to-32bpp-xtile-upscaling)
[412.541750] Starting subtest: flip-64bpp-xtile-to-32bpp-xtile-upscaling
[412.543994] Starting dynamic subtest: pipe-A-default-mode
[415.232339] Dynamic subtest pipe-A-default-mode: SUCCESS (2.690s)
[415.234621] Subtest flip-64bpp-xtile-to-32bpp-xtile-upscaling: SUCCESS (2.691s)
[416.091438] [064/131] (601s left) api_intel_allocator (alloc-simple)
[416.149721] Starting subtest: alloc-simple
[416.152092] Subtest alloc-simple: SUCCESS (0.003s)
[416.301579] [065/131] (601s left) kms_properties (connector-properties-atomic)
[416.402832] Starting subtest: connector-properties-atomic
[416.405193] Starting dynamic subtest: pipe-A-eDP-1
[424.008050] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.605s)
[424.018056] Starting dynamic subtest: pipe-None-DP-1
[424.022342] Dynamic subtest pipe-None-DP-1: SUCCESS (0.001s)
[424.031856] Starting dynamic subtest: pipe-None-HDMI-A-1
[424.036566] Dynamic subtest pipe-None-HDMI-A-1: SUCCESS (0.001s)
[424.045047] Starting dynamic subtest: pipe-None-DP-2
[424.049123] Dynamic subtest pipe-None-DP-2: SUCCESS (0.001s)
[424.057400] Starting dynamic subtest: pipe-None-HDMI-A-2
[424.061515] Dynamic subtest pipe-None-HDMI-A-2: SUCCESS (0.001s)
[424.070124] Starting dynamic subtest: pipe-None-DP-3
[424.074731] Dynamic subtest pipe-None-DP-3: SUCCESS (0.001s)
[424.083260] Starting dynamic subtest: pipe-None-DP-4
[424.087892] Dynamic subtest pipe-None-DP-4: SUCCESS (0.001s)
[424.090181] Subtest connector-properties-atomic: SUCCESS (7.616s)
[424.871621] [066/131] (592s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-blt)
[424.969774] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-blt
[424.973994] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-blt: SKIP (0.000s)
[425.065515] [067/131] (592s left) gem_exec_schedule (preempt-queue-chain)
[425.135728] Subtest preempt-queue-chain: SKIP (0.000s)
[425.425461] [068/131] (592s left) kms_psr (psr-cursor-plane-onoff)
[425.507682] Starting subtest: psr-cursor-plane-onoff
[425.509941] Starting dynamic subtest: eDP-1
[427.254328] Dynamic subtest eDP-1: SUCCESS (1.747s)
[427.256631] Subtest psr-cursor-plane-onoff: SUCCESS (1.748s)
[428.132299] [069/131] (589s left) core_setmaster (master-drop-set-shared-fd)
[428.210473] Starting subtest: master-drop-set-shared-fd
[428.217919] Subtest master-drop-set-shared-fd: SUCCESS (0.010s)
[428.255444] [070/131] (589s left) tools_test (tools_test)
[428.300895] Starting subtest: tools_test
[428.347817] Subtest tools_test: SUCCESS (0.061s)
[428.408534] [071/131] (589s left) i915_suspend (fence-restore-tiled2untiled)
[428.458109] Starting subtest: fence-restore-tiled2untiled
[428.462421] Subtest fence-restore-tiled2untiled: SKIP (0.000s)
[428.567224] [072/131] (589s left) kms_plane_multiple (tiling-x)
[428.666900] Starting subtest: tiling-x
[428.669202] Starting dynamic subtest: pipe-A-eDP-1
[432.332956] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.665s)
[432.343162] Starting dynamic subtest: pipe-B-eDP-1
[436.722664] Dynamic subtest pipe-B-eDP-1: SUCCESS (4.390s)
[436.732923] Starting dynamic subtest: pipe-C-eDP-1
[441.022052] Dynamic subtest pipe-C-eDP-1: SUCCESS (4.298s)
[441.031937] Starting dynamic subtest: pipe-D-eDP-1
[445.338293] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.315s)
[445.340821] Subtest tiling-x: SUCCESS (16.673s)
[446.135777] [073/131] (571s left) gem_ctx_persistence (process)
[446.193852] Starting subtest: process
[446.415507] Subtest process: SUCCESS (0.221s)
[446.492564] [074/131] (571s left) gem_sync (basic-store-all)
[446.551562] Starting subtest: basic-store-all
[449.843091] Subtest basic-store-all: SUCCESS (3.301s)
[450.028281] [075/131] (567s left) syncobj_timeline (etime-single-wait-all-for-submit-available-unsubmitted)
[450.080085] Starting subtest: etime-single-wait-all-for-submit-available-unsubmitted
[450.187408] Subtest etime-single-wait-all-for-submit-available-unsubmitted: SUCCESS (0.107s)
[450.263250] [076/131] (567s left) syncobj_wait (invalid-multi-wait-all-unsubmitted-submitted)
[450.319123] Starting subtest: invalid-multi-wait-all-unsubmitted-submitted
[450.321098] Subtest invalid-multi-wait-all-unsubmitted-submitted: SUCCESS (0.000s)
[450.429469] [077/131] (567s left) gem_exec_reloc (basic-cpu-wc-active)
[450.489458] Subtest basic-cpu-wc-active: SKIP (0.000s)
[450.552301] [078/131] (567s left) kms_atomic_transition (plane-all-transition-nonblocking)
[450.647831] Starting subtest: plane-all-transition-nonblocking
[450.650007] Starting dynamic subtest: pipe-A-eDP-1
[453.153279] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.504s)
[453.471120] Starting dynamic subtest: pipe-B-eDP-1
[456.677134] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.215s)
[456.973449] Subtest plane-all-transition-nonblocking: SUCCESS (6.323s)
[457.812886] [079/131] (560s left) gem_exec_schedule (in-order)
[457.892508] Starting subtest: in-order
[457.894826] Starting dynamic subtest: rcs0
[457.985024] Dynamic subtest rcs0: SUCCESS (0.100s)
[457.996089] Starting dynamic subtest: vcs0
[458.065884] Dynamic subtest vcs0: SUCCESS (0.080s)
[458.079842] Starting dynamic subtest: vcs1
[458.143317] Dynamic subtest vcs1: SUCCESS (0.077s)
[458.156032] Starting dynamic subtest: vecs0
[458.217378] Dynamic subtest vecs0: SUCCESS (0.073s)
[458.228816] Starting dynamic subtest: ccs0
[458.297773] Dynamic subtest ccs0: SUCCESS (0.080s)
[458.300193] Subtest in-order: SUCCESS (0.414s)
[460.073777] [080/131] (558s left) i915_pm_rps (waitboost)
[460.144105] Starting subtest: waitboost
[460.214776] Subtest waitboost: FAIL (0.005s)
[460.287412] [081/131] (557s left) gem_userptr_blits (sync-unmap-after-close)
[460.338667] Starting subtest: sync-unmap-after-close
[460.352836] Subtest sync-unmap-after-close: SUCCESS (0.013s)
[460.492922] [082/131] (557s left) kms_ccs (crc-primary-suspend-4-tiled-lnl-ccs)
[460.588842] Starting subtest: crc-primary-suspend-4-tiled-lnl-ccs
[460.593291] Subtest crc-primary-suspend-4-tiled-lnl-ccs: SKIP (0.000s)
[461.723469] [083/131] (556s left) syncobj_timeline (multi-wait-available-unsubmitted-signaled)
[461.782761] Starting subtest: multi-wait-available-unsubmitted-signaled
[461.784991] Subtest multi-wait-available-unsubmitted-signaled: SUCCESS (0.000s)
[461.890991] [084/131] (556s left) kms_cursor_legacy (basic-flip-after-cursor-legacy)
[462.011234] Starting subtest: basic-flip-after-cursor-legacy
[462.925001] Subtest basic-flip-after-cursor-legacy: SUCCESS (0.914s)
[463.749896] [085/131] (554s left) kms_frontbuffer_tracking (psr-1p-primscrn-indfb-msflip-blt)
[463.846874] Starting subtest: psr-1p-primscrn-indfb-msflip-blt
[471.105652] Subtest psr-1p-primscrn-indfb-msflip-blt: SUCCESS (7.259s)
[471.250547] [086/131] (547s left) kms_vblank (ts-continuation-modeset)
[471.344897] Starting subtest: ts-continuation-modeset
[471.347136] Starting dynamic subtest: pipe-A-eDP-1
[472.791429] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.444s)
[472.806882] Starting dynamic subtest: pipe-D-eDP-1
[474.953522] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.160s)
[474.955855] Subtest ts-continuation-modeset: SUCCESS (3.608s)
[475.745936] [087/131] (542s left) kms_cursor_legacy (flip-vs-cursor-varying-size)
[475.866055] Starting subtest: flip-vs-cursor-varying-size
[483.937725] Subtest flip-vs-cursor-varying-size: SUCCESS (8.068s)
[484.772804] [088/131] (533s left) gem_exec_params (dr4-dirt)
[484.839722] Starting subtest: DR4-dirt
[484.842038] Subtest DR4-dirt: SUCCESS (0.000s)
[484.954266] [089/131] (533s left) kms_cursor_legacy (cursorb-vs-flipb-legacy)
[485.090212] Starting subtest: cursorB-vs-flipB-legacy
[485.094667] Subtest cursorB-vs-flipB-legacy: SKIP (0.001s)
[485.228328] [090/131] (533s left) gem_eio (wait-wedge-10ms)
[485.457471] Starting subtest: wait-wedge-10ms
[486.981165] Subtest wait-wedge-10ms: SUCCESS (1.523s)
[487.137185] [091/131] (531s left) gem_ctx_bad_destroy (invalid-default-ctx)
[487.185986] Starting subtest: invalid-default-ctx
[487.188247] Subtest invalid-default-ctx: SUCCESS (0.000s)
[487.262096] [092/131] (531s left) gem_ppgtt (shrink-vs-evict-pinned)
[487.322522] Starting subtest: shrink-vs-evict-pinned
[492.879465] Subtest shrink-vs-evict-pinned: SUCCESS (5.554s)
[492.997715] [093/131] (525s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-onoff)
[493.100161] Starting subtest: fbc-2p-primscrn-cur-indfb-onoff
[493.104192] Subtest fbc-2p-primscrn-cur-indfb-onoff: SKIP (0.000s)
[493.211044] [094/131] (525s left) kms_cursor_crc (cursor-sliding-64x21)
[493.416592] Starting subtest: cursor-sliding-64x21
[493.461824] Subtest cursor-sliding-64x21: SKIP (0.040s)
[493.712011] [095/131] (525s left) kms_lease (lease-again)
[493.813832] Starting subtest: lease-again
[493.816214] Starting dynamic subtest: pipe-A-eDP-1
[493.818892] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.003s)
[493.836263] Starting dynamic subtest: pipe-B-eDP-1
[493.838771] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.002s)
[493.850193] Starting dynamic subtest: pipe-C-eDP-1
[493.852418] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.002s)
[493.863332] Starting dynamic subtest: pipe-D-eDP-1
[493.865660] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.002s)
[493.867818] Subtest lease-again: SUCCESS (0.013s)
[493.942273] [096/131] (524s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-0-hflip)
[494.050427] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-0-hflip
[494.054250] Subtest y-tiled-max-hw-stride-32bpp-rotate-0-hflip: SKIP (0.000s)
[494.170461] [097/131] (524s left) gem_exec_balancer (full-late)
[494.231882] Starting subtest: full-late
[498.785086] Subtest full-late: SUCCESS (4.552s)
[499.126507] [098/131] (519s left) kms_frontbuffer_tracking (fbc-rgb565-draw-mmap-cpu)
[499.239909] Starting subtest: fbc-rgb565-draw-mmap-cpu
[503.282264] Subtest fbc-rgb565-draw-mmap-cpu: SUCCESS (4.046s)
[504.455463] [099/131] (514s left) gen9_exec_parse (allowed-all)
[504.520149] Subtest allowed-all: SKIP (0.000s)
[504.586785] [100/131] (514s left) prime_mmap_coherency (write)
[504.640115] Starting subtest: write
[510.020934] Subtest write: SUCCESS (5.380s)
[510.187313] [101/131] (508s left) sriov_basic (enable-vfs-autoprobe-off)
[510.252577] Starting subtest: enable-vfs-autoprobe-off
[510.254946] Starting dynamic subtest: numvfs-1
[510.329580] Dynamic subtest numvfs-1: FAIL (0.005s)
[510.340543] Starting dynamic subtest: numvfs-2
[510.412973] Dynamic subtest numvfs-2: FAIL (0.004s)
[510.424236] Starting dynamic subtest: numvfs-3
[510.497245] Dynamic subtest numvfs-3: FAIL (0.004s)
[510.507565] Starting dynamic subtest: numvfs-4
[510.580875] Dynamic subtest numvfs-4: FAIL (0.004s)
[510.591106] Starting dynamic subtest: numvfs-5
[510.664259] Dynamic subtest numvfs-5: FAIL (0.004s)
[510.675619] Starting dynamic subtest: numvfs-6
[510.749072] Dynamic subtest numvfs-6: FAIL (0.004s)
[510.759643] Starting dynamic subtest: numvfs-7
[510.832436] Dynamic subtest numvfs-7: FAIL (0.004s)
[510.842745] Starting dynamic subtest: numvfs-random
[510.911804] Dynamic subtest numvfs-random: FAIL (0.004s)
[510.921335] Starting dynamic subtest: numvfs-all
[510.990060] Dynamic subtest numvfs-all: FAIL (0.515s)
[510.992197] Subtest enable-vfs-autoprobe-off: FAIL (0.552s)
[511.030441] [102/131] (508s left) kms_flip_scaled_crc (flip-32bpp-ytileccs-to-64bpp-ytile-downscaling)
[511.124116] Starting subtest: flip-32bpp-ytileccs-to-64bpp-ytile-downscaling
[511.126149] Starting dynamic subtest: pipe-A-default-mode
[511.415665] Dynamic subtest pipe-A-default-mode: SKIP (0.287s)
[511.420168] Subtest flip-32bpp-ytileccs-to-64bpp-ytile-downscaling: SKIP (0.288s)
[512.266797] [103/131] (506s left) kms_flip (basic-plain-flip)
[512.371814] Starting subtest: basic-plain-flip
[512.374172] Starting dynamic subtest: A-eDP1
[514.058740] Dynamic subtest A-eDP1: SUCCESS (1.686s)
[514.069427] Starting dynamic subtest: B-eDP1
[515.679106] Dynamic subtest B-eDP1: SUCCESS (1.619s)
[515.691117] Starting dynamic subtest: C-eDP1
[517.296411] Dynamic subtest C-eDP1: SUCCESS (1.615s)
[517.308717] Starting dynamic subtest: D-eDP1
[518.932857] Dynamic subtest D-eDP1: SUCCESS (1.635s)
[518.938812] Subtest basic-plain-flip: SUCCESS (6.567s)
[520.082139] [104/131] (499s left) kms_big_fb (yf-tiled-16bpp-rotate-90)
[520.185934] Starting subtest: yf-tiled-16bpp-rotate-90
[520.189908] Subtest yf-tiled-16bpp-rotate-90: SKIP (0.000s)
[520.298886] [105/131] (498s left) gem_exec_fence (submit-chain)
[520.484157] Starting subtest: submit-chain
[520.501301] Subtest submit-chain: SUCCESS (0.018s)
[521.993443] [106/131] (497s left) prime_mmap (test_refcounting)
[522.053176] Starting subtest: test_refcounting
[522.055356] Starting dynamic subtest: test_refcounting-smem
[522.083697] Dynamic subtest test_refcounting-smem: SUCCESS (0.032s)
[522.086119] Subtest test_refcounting: SUCCESS (0.033s)
[522.213786] [107/131] (497s left) kms_big_fb (4-tiled-64bpp-rotate-180)
[522.318392] Starting subtest: 4-tiled-64bpp-rotate-180
[523.932400] Subtest 4-tiled-64bpp-rotate-180: SUCCESS (1.614s)
[524.118123] [108/131] (495s left) api_intel_allocator (simple-allocator)
[524.176862] Starting subtest: simple-allocator
[524.179195] Starting dynamic subtest: basic
[524.181494] Dynamic subtest basic: SUCCESS (0.004s)
[524.195618] Starting dynamic subtest: parallel-one
[524.361313] Dynamic subtest parallel-one: SUCCESS (0.180s)
[524.373270] Starting dynamic subtest: print
[524.375503] Dynamic subtest print: SUCCESS (0.000s)
[524.384382] Starting dynamic subtest: reuse
[524.386539] Dynamic subtest reuse: SUCCESS (0.000s)
[524.395524] Starting dynamic subtest: reserve
[524.397716] Dynamic subtest reserve: SUCCESS (0.000s)
[524.406745] Starting dynamic subtest: fork-reopen-allocator
[524.408860] Dynamic subtest fork-reopen-allocator: SUCCESS (0.012s)
[524.411012] Subtest simple-allocator: SUCCESS (0.201s)
[524.517287] [109/131] (494s left) gem_fence_thrash (bo-write-verify-x)
[524.551207] Starting subtest: bo-write-verify-x
[524.571109] Subtest bo-write-verify-x: SKIP (0.021s)
[524.628029] [110/131] (494s left) perf (oa-formats)
[524.708245] Starting subtest: oa-formats
[524.710584] Starting dynamic subtest: 0-rcs0
[524.720872] Dynamic subtest 0-rcs0: SUCCESS (0.012s)
[524.731230] Starting dynamic subtest: 1-vcs1
[524.745861] Dynamic subtest 1-vcs1: SUCCESS (0.024s)
[524.748188] Subtest oa-formats: SUCCESS (0.038s)
[524.810804] [111/131] (494s left) kms_cursor_crc (cursor-onscreen-128x42)
[525.040968] Starting subtest: cursor-onscreen-128x42
[525.086596] Subtest cursor-onscreen-128x42: SKIP (0.040s)
[525.290037] [112/131] (494s left) gem_render_copy (yf-tiled-to-vebox-y-tiled)
[525.350872] Starting subtest: yf-tiled-to-vebox-y-tiled
[525.355489] Subtest yf-tiled-to-vebox-y-tiled: SKIP (0.000s)
[525.537163] [113/131] (494s left) kms_pm_rpm (fences-dpms)
[527.060572] Starting subtest: fences-dpms
[527.066167] Subtest fences-dpms: SKIP (0.000s)
[527.813095] [114/131] (491s left) kms_ccs (missing-ccs-buffer-4-tiled-mtl-rc-ccs)
[527.914853] Starting subtest: missing-ccs-buffer-4-tiled-mtl-rc-ccs
[527.917078] Starting dynamic subtest: pipe-A-eDP-1
[527.937921] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s)
[527.949781] Starting dynamic subtest: pipe-B-eDP-1
[527.968557] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[527.977533] Starting dynamic subtest: pipe-C-eDP-1
[527.996228] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[528.005067] Starting dynamic subtest: pipe-D-eDP-1
[528.024366] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[528.026267] Subtest missing-ccs-buffer-4-tiled-mtl-rc-ccs: SUCCESS (0.005s)
[530.141705] [115/131] (489s left) kms_psr (psr2-basic)
[530.243922] Starting subtest: psr2-basic
[530.246240] Starting dynamic subtest: eDP-1
[531.804557] Dynamic subtest eDP-1: SUCCESS (1.559s)
[531.807149] Subtest psr2-basic: SUCCESS (1.560s)
[532.592646] [116/131] (487s left) kms_frontbuffer_tracking (psr-1p-offscren-pri-shrfb-draw-mmap-gtt)
[532.696060] Starting subtest: psr-1p-offscren-pri-shrfb-draw-mmap-gtt
[532.700508] Subtest psr-1p-offscren-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[532.787666] [117/131] (486s left) kms_psr (fbc-pr-sprite-render)
[532.884910] Starting subtest: fbc-pr-sprite-render
[532.888988] Subtest fbc-pr-sprite-render: SKIP (0.000s)
[532.958754] [118/131] (486s left) kms_psr (pr-cursor-mmap-gtt)
[533.052926] Starting subtest: pr-cursor-mmap-gtt
[533.057399] Subtest pr-cursor-mmap-gtt: SKIP (0.000s)
[533.128753] [119/131] (486s left) kms_psr (fbc-psr-basic)
[533.229553] Starting subtest: fbc-psr-basic
[533.231762] Starting dynamic subtest: eDP-1
[533.235773] Dynamic subtest eDP-1: SKIP (0.000s)
[533.239791] Subtest fbc-psr-basic: SKIP (0.001s)
[533.303255] [120/131] (486s left) gem_exec_schedule (wide)
[533.473430] Starting subtest: wide
[533.475904] Starting dynamic subtest: rcs0
[543.403447] Dynamic subtest rcs0: SUCCESS (9.930s)
[543.414890] Starting dynamic subtest: vcs0
[552.845500] Dynamic subtest vcs0: SUCCESS (9.441s)
[552.855655] Starting dynamic subtest: vcs1
[563.912317] Dynamic subtest vcs1: SUCCESS (11.066s)
[563.922850] Starting dynamic subtest: vecs0
[575.830896] Dynamic subtest vecs0: SUCCESS (11.917s)
[575.843443] Starting dynamic subtest: ccs0
[589.805340] Dynamic subtest ccs0: SUCCESS (13.976s)
[589.807665] Subtest wide: SUCCESS (56.337s)
[591.673654] [121/131] (428s left) gem_exec_parallel (contexts)
[591.737547] Starting subtest: contexts
[591.739913] Starting dynamic subtest: rcs0
[595.290513] Dynamic subtest rcs0: SUCCESS (3.552s)
[595.301071] Starting dynamic subtest: bcs0
[599.121143] Dynamic subtest bcs0: SUCCESS (3.828s)
[599.133797] Starting dynamic subtest: vcs0
[605.295835] Dynamic subtest vcs0: SUCCESS (6.174s)
[605.306320] Starting dynamic subtest: vcs1
[609.425499] Dynamic subtest vcs1: SUCCESS (4.128s)
[609.435796] Starting dynamic subtest: vecs0
[613.456217] Dynamic subtest vecs0: SUCCESS (4.028s)
[613.468343] Starting dynamic subtest: ccs0
[617.440874] Dynamic subtest ccs0: SUCCESS (3.983s)
[617.443441] Subtest contexts: SUCCESS (25.706s)
[617.628673] [122/131] (402s left) kms_plane_alpha_blend (alpha-basic)
[617.726419] Starting subtest: alpha-basic
[618.028034] Starting dynamic subtest: pipe-A-eDP-1
[619.948342] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.920s)
[619.975805] Starting dynamic subtest: pipe-D-eDP-1
[622.624835] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.657s)
[622.627197] Subtest alpha-basic: SUCCESS (4.898s)
[623.424179] [123/131] (396s left) gem_cs_tlb (engines)
[623.475664] Starting subtest: engines
[623.477900] Starting dynamic subtest: rcs0
[625.633090] Dynamic subtest rcs0: SUCCESS (2.154s)
[625.646193] Starting dynamic subtest: bcs0
[627.788439] Dynamic subtest bcs0: SUCCESS (2.154s)
[627.800621] Starting dynamic subtest: vcs0
[629.942465] Dynamic subtest vcs0: SUCCESS (2.154s)
[629.954195] Starting dynamic subtest: vcs1
[632.098133] Dynamic subtest vcs1: SUCCESS (2.155s)
[632.107239] Starting dynamic subtest: vecs0
[634.253630] Dynamic subtest vecs0: SUCCESS (2.155s)
[634.264783] Starting dynamic subtest: ccs0
[636.407354] Dynamic subtest ccs0: SUCCESS (2.154s)
[636.410025] Subtest engines: SUCCESS (12.930s)
[636.525580] [124/131] (383s left) dumb_buffer (map-invalid-size)
[636.572702] Starting subtest: map-invalid-size
[636.574967] Subtest map-invalid-size: SUCCESS (0.000s)
[636.680485] [125/131] (383s left) kms_content_protection (dp-mst-lic-type-0)
[636.820033] Starting subtest: dp-mst-lic-type-0
[636.824336] Subtest dp-mst-lic-type-0: SKIP (0.000s)
[636.986339] [126/131] (383s left) kms_chamelium_edid (dp-mode-timings)
[637.364895] Subtest dp-mode-timings: SKIP (0.000s)
[638.126562] [127/131] (382s left) kms_ccs (random-ccs-data-4-tiled-dg2-rc-ccs-cc)
[638.230675] Starting subtest: random-ccs-data-4-tiled-dg2-rc-ccs-cc
[638.232862] Starting dynamic subtest: pipe-A-eDP-1
[638.256905] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[638.267672] Starting dynamic subtest: pipe-B-eDP-1
[638.291005] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[638.300743] Starting dynamic subtest: pipe-C-eDP-1
[638.323906] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[638.333547] Starting dynamic subtest: pipe-D-eDP-1
[638.357113] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[638.361459] Subtest random-ccs-data-4-tiled-dg2-rc-ccs-cc: SKIP (0.004s)
[640.402789] [128/131] (379s left) vgem_basic (busy-fence)
[640.443331] Starting subtest: busy-fence
[640.445630] Subtest busy-fence: SUCCESS (0.000s)
[640.500167] [129/131] (379s left) kms_flip (2x-blocking-absolute-wf_vblank)
[640.595888] Starting subtest: 2x-blocking-absolute-wf_vblank
[640.607232] Subtest 2x-blocking-absolute-wf_vblank: SKIP (0.011s)
[640.686435] [130/131] (379s left) gem_lmem_swapping (verify-random)
[640.730779] Subtest verify-random: SKIP (0.000s)
[640.776754] [131/131] (379s left) gem_softpin (allocator-evict)
[640.837699] Starting subtest: allocator-evict
[640.839983] Starting dynamic subtest: rcs0
[664.762947] Dynamic subtest rcs0: SUCCESS (23.928s)
[664.779205] Starting dynamic subtest: bcs0
[688.482631] Dynamic subtest bcs0: SUCCESS (23.721s)
[688.494561] Starting dynamic subtest: vcs0
[712.464502] Dynamic subtest vcs0: SUCCESS (23.973s)
[712.475119] Starting dynamic subtest: vcs1
[736.325436] Dynamic subtest vcs1: SUCCESS (23.848s)
[736.338383] Starting dynamic subtest: vecs0
[760.289739] Dynamic subtest vecs0: SUCCESS (23.955s)
[760.300377] Starting dynamic subtest: ccs0
[784.561756] Dynamic subtest ccs0: SUCCESS (24.266s)
[784.564628] Subtest allocator-evict: SUCCESS (143.698s)
[784.638140] Closing watchdogs
results: parsing output: 0/ for test: core_getclient
results: parsing output: 1/ for test: kms_draw_crc
results: parsing output: 2/ for test: syncobj_timeline
results: parsing output: 3/ for test: kms_big_fb
results: parsing output: 4/ for test: gem_userptr_blits
results: parsing output: 5/ for test: kms_plane_scaling
results: parsing output: 6/ for test: kms_async_flips
results: parsing output: 7/ for test: gem_softpin
results: parsing output: 8/ for test: kms_big_fb
results: parsing output: 9/ for test: kms_psr2_sf
results: parsing output: 10/ for test: kms_panel_fitting
results: parsing output: 11/ for test: gem_mmap_wc
results: parsing output: 12/ for test: kms_plane
results: parsing output: 13/ for test: kms_psr2_sf
results: parsing output: 14/ for test: kms_ccs
results: parsing output: 15/ for test: syncobj_basic
results: parsing output: 16/ for test: gem_userptr_blits
results: parsing output: 17/ for test: gem_ctx_persistence
results: parsing output: 18/ for test: kms_flip
results: parsing output: 19/ for test: kms_frontbuffer_tracking
results: parsing output: 20/ for test: gen9_exec_parse
results: parsing output: 21/ for test: kms_frontbuffer_tracking
results: parsing output: 22/ for test: kms_frontbuffer_tracking
results: parsing output: 23/ for test: kms_frontbuffer_tracking
results: parsing output: 24/ for test: gem_exec_fence
results: parsing output: 25/ for test: kms_ccs
results: parsing output: 26/ for test: perf
results: parsing output: 27/ for test: kms_frontbuffer_tracking
results: parsing output: 28/ for test: gem_mmap_gtt
results: parsing output: 29/ for test: i915_hangman
results: parsing output: 30/ for test: kms_frontbuffer_tracking
results: parsing output: 31/ for test: gem_exec_whisper
results: parsing output: 32/ for test: gem_ccs
results: parsing output: 33/ for test: kms_psr
results: parsing output: 34/ for test: gem_exec_reloc
results: parsing output: 35/ for test: kms_prop_blob
results: parsing output: 36/ for test: kms_frontbuffer_tracking
results: parsing output: 37/ for test: kms_big_fb
results: parsing output: 38/ for test: kms_invalid_mode
results: parsing output: 39/ for test: i915_drm_fdinfo
results: parsing output: 40/ for test: kms_frontbuffer_tracking
results: parsing output: 41/ for test: kms_flip
results: parsing output: 42/ for test: kms_frontbuffer_tracking
results: parsing output: 43/ for test: kms_chamelium_hpd
results: parsing output: 44/ for test: kms_cursor_legacy
results: parsing output: 45/ for test: gem_exec_balancer
results: parsing output: 46/ for test: gem_fence_thrash
results: parsing output: 47/ for test: kms_atomic_transition
results: parsing output: 48/ for test: gem_pxp
results: parsing output: 49/ for test: perf_pmu
results: parsing output: 50/ for test: kms_flip
results: parsing output: 51/ for test: kms_big_fb
results: parsing output: 52/ for test: kms_color
results: parsing output: 53/ for test: gem_render_copy_redux
results: parsing output: 54/ for test: syncobj_timeline
results: parsing output: 55/ for test: kms_cursor_legacy
results: parsing output: 56/ for test: syncobj_wait
results: parsing output: 57/ for test: kms_sequence
results: parsing output: 58/ for test: kms_frontbuffer_tracking
results: parsing output: 59/ for test: syncobj_timeline
results: parsing output: 60/ for test: kms_flip
results: parsing output: 61/ for test: gem_fence_thrash
results: parsing output: 62/ for test: kms_flip_scaled_crc
results: parsing output: 63/ for test: api_intel_allocator
results: parsing output: 64/ for test: kms_properties
results: parsing output: 65/ for test: kms_frontbuffer_tracking
results: parsing output: 66/ for test: gem_exec_schedule
results: parsing output: 67/ for test: kms_psr
results: parsing output: 68/ for test: core_setmaster
results: parsing output: 69/ for test: tools_test
results: parsing output: 70/ for test: i915_suspend
results: parsing output: 71/ for test: kms_plane_multiple
results: parsing output: 72/ for test: gem_ctx_persistence
results: parsing output: 73/ for test: gem_sync
results: parsing output: 74/ for test: syncobj_timeline
results: parsing output: 75/ for test: syncobj_wait
results: parsing output: 76/ for test: gem_exec_reloc
results: parsing output: 77/ for test: kms_atomic_transition
results: parsing output: 78/ for test: gem_exec_schedule
results: parsing output: 79/ for test: i915_pm_rps
results: parsing output: 80/ for test: gem_userptr_blits
results: parsing output: 81/ for test: kms_ccs
results: parsing output: 82/ for test: syncobj_timeline
results: parsing output: 83/ for test: kms_cursor_legacy
results: parsing output: 84/ for test: kms_frontbuffer_tracking
results: parsing output: 85/ for test: kms_vblank
results: parsing output: 86/ for test: kms_cursor_legacy
results: parsing output: 87/ for test: gem_exec_params
results: parsing output: 88/ for test: kms_cursor_legacy
results: parsing output: 89/ for test: gem_eio
results: parsing output: 90/ for test: gem_ctx_bad_destroy
results: parsing output: 91/ for test: gem_ppgtt
results: parsing output: 92/ for test: kms_frontbuffer_tracking
results: parsing output: 93/ for test: kms_cursor_crc
results: parsing output: 94/ for test: kms_lease
results: parsing output: 95/ for test: kms_big_fb
results: parsing output: 96/ for test: gem_exec_balancer
results: parsing output: 97/ for test: kms_frontbuffer_tracking
results: parsing output: 98/ for test: gen9_exec_parse
results: parsing output: 99/ for test: prime_mmap_coherency
results: parsing output: 100/ for test: sriov_basic
results: parsing output: 101/ for test: kms_flip_scaled_crc
results: parsing output: 102/ for test: kms_flip
results: parsing output: 103/ for test: kms_big_fb
results: parsing output: 104/ for test: gem_exec_fence
results: parsing output: 105/ for test: prime_mmap
results: parsing output: 106/ for test: kms_big_fb
results: parsing output: 107/ for test: api_intel_allocator
results: parsing output: 108/ for test: gem_fence_thrash
results: parsing output: 109/ for test: perf
results: parsing output: 110/ for test: kms_cursor_crc
results: parsing output: 111/ for test: gem_render_copy
results: parsing output: 112/ for test: kms_pm_rpm
results: parsing output: 113/ for test: kms_ccs
results: parsing output: 114/ for test: kms_psr
results: parsing output: 115/ for test: kms_frontbuffer_tracking
results: parsing output: 116/ for test: kms_psr
results: parsing output: 117/ for test: kms_psr
results: parsing output: 118/ for test: kms_psr
results: parsing output: 119/ for test: gem_exec_schedule
results: parsing output: 120/ for test: gem_exec_parallel
results: parsing output: 121/ for test: kms_plane_alpha_blend
results: parsing output: 122/ for test: gem_cs_tlb
results: parsing output: 123/ for test: dumb_buffer
results: parsing output: 124/ for test: kms_content_protection
results: parsing output: 125/ for test: kms_chamelium_edid
results: parsing output: 126/ for test: kms_ccs
results: parsing output: 127/ for test: vgem_basic
results: parsing output: 128/ for test: kms_flip
results: parsing output: 129/ for test: gem_lmem_swapping
results: parsing output: 130/ for test: gem_softpin
Done.