[57.576715] Initializing watchdogs
[57.576764]   /dev/watchdog0
[57.592131] [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.596692] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[57.599067] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[57.602402] [001/133] (960s left) gem_userptr_blits (sync-unmap)
[57.697492] Starting subtest: sync-unmap
[57.716437] Subtest sync-unmap: SUCCESS (0.019s)
[57.854644] [002/133] (960s left) gem_exec_params (rel-constants-invalid)
[57.925224] Starting subtest: rel-constants-invalid
[57.927559] Subtest rel-constants-invalid: SUCCESS (0.000s)
[58.036496] [003/133] (960s left) kms_setmode (invalid-clone-single-crtc-stealing)
[58.088137] Starting subtest: invalid-clone-single-crtc-stealing
[58.094718] Subtest invalid-clone-single-crtc-stealing: SKIP (0.001s)
[58.197193] [004/133] (960s left) kms_ccs (crc-primary-suspend-yf-tiled-ccs)
[58.298891] Starting subtest: crc-primary-suspend-yf-tiled-ccs
[58.301255] Starting dynamic subtest: pipe-A-eDP-1
[58.311343] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[58.325732] Starting dynamic subtest: pipe-B-eDP-1
[58.336173] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[58.344692] Starting dynamic subtest: pipe-C-eDP-1
[58.353244] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[58.359759] Starting dynamic subtest: pipe-D-eDP-1
[58.366967] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[58.370570] Subtest crc-primary-suspend-yf-tiled-ccs: SKIP (0.003s)
[60.602551] [005/133] (957s left) gem_gtt_cpu_tlb
[60.720872] [006/133] (957s left) testdisplay
[61.068100] [007/133] (957s left) vgem_basic (debugfs)
[61.144628] Starting subtest: debugfs
[61.147089] Subtest debugfs: SUCCESS (0.001s)
[61.201878] [FACT vgem_basic (debugfs)] new: kernel.kmod_is_loaded.vgem: true
[61.205045] [008/133] (957s left) kms_frontbuffer_tracking (fbc-tiling-4)
[61.302775] Starting subtest: fbc-tiling-4
[65.512857] Subtest fbc-tiling-4: SUCCESS (4.214s)
[66.686135] [009/133] (951s left) i915_pm_rps (min-max-config-loaded)
[66.784849] Starting subtest: min-max-config-loaded
[66.789491] Subtest min-max-config-loaded: SKIP (0.001s)
[66.940757] [010/133] (951s left) kms_dither (fb-8bpc-vs-panel-6bpc)
[67.228615] Starting subtest: fb-8bpc-vs-panel-6bpc
[67.231445] Starting dynamic subtest: pipe-A-eDP-1
[68.678922] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.450s)
[68.681028] Subtest fb-8bpc-vs-panel-6bpc: SUCCESS (1.451s)
[69.559196] [011/133] (948s left) gem_sync (basic-store-each)
[69.638283] Starting subtest: basic-store-each
[72.003073] Subtest basic-store-each: SUCCESS (2.377s)
[72.191676] [012/133] (946s left) kms_flip (2x-flip-vs-suspend-interruptible)
[72.286176] Starting subtest: 2x-flip-vs-suspend-interruptible
[72.290614] Subtest 2x-flip-vs-suspend-interruptible: SKIP (0.002s)
[72.366250] [013/133] (946s left) sw_sync (sync_expired_merge)
[72.399712] Starting subtest: sync_expired_merge
[73.474756] Subtest sync_expired_merge: SUCCESS (1.074s)
[73.531243] [014/133] (945s left) syncobj_timeline (etime-multi-wait-all-for-submit-available-unsubmitted)
[73.595761] Starting subtest: etime-multi-wait-all-for-submit-available-unsubmitted
[73.698479] Subtest etime-multi-wait-all-for-submit-available-unsubmitted: SUCCESS (0.102s)
[73.777566] [015/133] (944s left) kms_vrr (seamless-rr-switch-vrr)
[73.870357] Starting subtest: seamless-rr-switch-vrr
[73.876858] Subtest seamless-rr-switch-vrr: SKIP (0.000s)
[73.944628] [016/133] (944s left) gem_exec_balancer (busy)
[74.008463] Starting subtest: busy
[75.925623] Subtest busy: SUCCESS (1.915s)
[76.265380] [017/133] (942s left) gem_ctx_shared (q-promotion)
[76.326861] Starting subtest: Q-promotion
[76.329359] Starting dynamic subtest: rcs0
[76.426918] Dynamic subtest rcs0: SUCCESS (0.100s)
[76.443255] Starting dynamic subtest: vcs0
[76.541404] Dynamic subtest vcs0: SUCCESS (0.113s)
[76.556438] Starting dynamic subtest: vcs1
[76.641922] Dynamic subtest vcs1: SUCCESS (0.101s)
[76.658499] Starting dynamic subtest: vecs0
[76.742970] Dynamic subtest vecs0: SUCCESS (0.100s)
[76.758557] Starting dynamic subtest: ccs0
[76.896706] Dynamic subtest ccs0: SUCCESS (0.152s)
[76.899158] Subtest Q-promotion: SUCCESS (0.568s)
[77.997396] [018/133] (940s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-mmap-wc)
[78.099302] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-mmap-wc
[81.636249] Subtest fbc-1p-primscrn-spr-indfb-draw-mmap-wc: SUCCESS (3.540s)
[82.856814] [019/133] (935s left) gem_pxp (create-protected-buffer)
[82.977846] Starting subtest: create-protected-buffer
[82.980671] Subtest create-protected-buffer: SUCCESS (0.000s)
[83.085340] [020/133] (935s left) kms_frontbuffer_tracking (fbc-indfb-scaledprimary)
[83.175192] Starting subtest: fbc-indfb-scaledprimary
[86.068072] Subtest fbc-indfb-scaledprimary: SUCCESS (2.896s)
[87.248082] [021/133] (931s left) kms_content_protection (dp-mst-type-0-hdcp14)
[87.384939] Starting subtest: dp-mst-type-0-hdcp14
[87.389612] Subtest dp-mst-type-0-hdcp14: SKIP (0.000s)
[87.497912] [022/133] (931s left) gem_mmap_gtt (basic-write-read-distinct)
[87.552196] Subtest basic-write-read-distinct: SKIP (0.000s)
[87.613245] [023/133] (931s left) kms_frontbuffer_tracking (psr-2p-scndscrn-indfb-pgflip-blt)
[87.701364] Starting subtest: psr-2p-scndscrn-indfb-pgflip-blt
[87.705509] Subtest psr-2p-scndscrn-indfb-pgflip-blt: SKIP (0.000s)
[87.791808] [024/133] (931s left) kms_joiner (invalid-modeset-big-joiner)
[87.888436] Starting subtest: invalid-modeset-big-joiner
[87.892540] Subtest invalid-modeset-big-joiner: SKIP (0.000s)
[87.953372] [025/133] (931s left) gen9_exec_parse (batch-invalid-length)
[88.023773] Subtest batch-invalid-length: SKIP (0.000s)
[88.091511] [026/133] (931s left) kms_plane_multiple (tiling-none)
[88.179510] Starting subtest: tiling-none
[88.181317] Starting dynamic subtest: pipe-A-eDP-1
[91.956820] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.779s)
[91.964963] Starting dynamic subtest: pipe-B-eDP-1
[96.500707] Dynamic subtest pipe-B-eDP-1: SUCCESS (4.541s)
[96.509999] Starting dynamic subtest: pipe-C-eDP-1
[100.945906] Dynamic subtest pipe-C-eDP-1: SUCCESS (4.445s)
[100.954208] Starting dynamic subtest: pipe-D-eDP-1
[105.300313] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.354s)
[105.302665] Subtest tiling-none: SUCCESS (17.124s)
[106.108020] [027/133] (913s left) kms_psr (psr-cursor-render)
[106.201045] Starting subtest: psr-cursor-render
[106.203331] Starting dynamic subtest: eDP-1
[107.902403] Dynamic subtest eDP-1: SUCCESS (1.700s)
[107.904409] Subtest psr-cursor-render: SUCCESS (1.701s)
[108.767068] [028/133] (910s left) kms_frontbuffer_tracking (psr-suspend)
[108.883524] Starting subtest: psr-suspend
[147.313556] Subtest psr-suspend: SUCCESS (8.125s)
[147.451947] [029/133] (871s left) tools_test (sysfs_l3_parity)
[147.511563] Starting subtest: sysfs_l3_parity
[147.600609] Subtest sysfs_l3_parity: SKIP (0.099s)
[147.657284] [030/133] (871s left) kms_pm_rpm (i2c)
[149.383033] Starting subtest: i2c
[154.872445] Subtest i2c: SUCCESS (5.475s)
[154.964241] [031/133] (864s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-180-async-flip)
[155.069022] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-180-async-flip
[155.895275] Subtest 4-tiled-max-hw-stride-64bpp-rotate-180-async-flip: SUCCESS (0.826s)
[156.049858] [032/133] (863s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-mmap-cpu)
[156.147043] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-mmap-cpu
[162.952917] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-mmap-cpu: SUCCESS (6.800s)
[163.082444] [033/133] (856s left) kms_cursor_legacy (flip-vs-cursor-busy-crc-legacy)
[163.199433] Starting subtest: flip-vs-cursor-busy-crc-legacy
[164.019149] Subtest flip-vs-cursor-busy-crc-legacy: SUCCESS (0.816s)
[164.825452] [034/133] (854s left) gem_eio (wait-10ms)
[165.065063] Starting subtest: wait-10ms
[165.439654] Subtest wait-10ms: SUCCESS (0.375s)
[165.599785] [035/133] (853s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-render)
[165.696986] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-render
[170.195645] Subtest fbc-1p-primscrn-pri-shrfb-draw-render: SUCCESS (4.499s)
[171.315914] [036/133] (848s left) kms_ccs (missing-ccs-buffer-4-tiled-mtl-rc-ccs)
[171.418134] Starting subtest: missing-ccs-buffer-4-tiled-mtl-rc-ccs
[171.420314] Starting dynamic subtest: pipe-A-eDP-1
[171.440036] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s)
[171.450820] Starting dynamic subtest: pipe-B-eDP-1
[171.469755] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[171.478709] Starting dynamic subtest: pipe-C-eDP-1
[171.497227] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[171.505849] Starting dynamic subtest: pipe-D-eDP-1
[171.524421] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[171.526517] Subtest missing-ccs-buffer-4-tiled-mtl-rc-ccs: SUCCESS (0.005s)
[173.666781] [037/133] (845s left) prime_busy (after)
[173.733163] Starting subtest: after
[173.738238] Starting dynamic subtest: rcs0
[173.777770] Dynamic subtest rcs0: SUCCESS (0.041s)
[173.788944] Starting dynamic subtest: bcs0
[173.837386] Dynamic subtest bcs0: SUCCESS (0.059s)
[173.847913] Starting dynamic subtest: vcs0
[173.878355] Dynamic subtest vcs0: SUCCESS (0.040s)
[173.887339] Starting dynamic subtest: vcs1
[173.919492] Dynamic subtest vcs1: SUCCESS (0.040s)
[173.930462] Starting dynamic subtest: vecs0
[173.959735] Dynamic subtest vecs0: SUCCESS (0.040s)
[173.968869] Starting dynamic subtest: ccs0
[174.000352] Dynamic subtest ccs0: SUCCESS (0.040s)
[174.109655] Subtest after: SUCCESS (0.375s)
[174.186939] [038/133] (845s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-0)
[174.289070] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-0
[174.293394] Subtest y-tiled-max-hw-stride-64bpp-rotate-0: SKIP (0.000s)
[174.388689] [039/133] (845s left) api_intel_allocator (two-level-inception-interruptible)
[174.449761] Starting subtest: two-level-inception-interruptible
[179.860451] Subtest two-level-inception-interruptible: SUCCESS (5.407s)
[179.977796] [040/133] (839s left) gem_gpgpu_fill (basic)
[180.037816] Starting subtest: basic
[180.040157] Starting dynamic subtest: smem
[180.045833] Dynamic subtest smem: SUCCESS (0.009s)
[180.048297] Subtest basic: SUCCESS (0.010s)
[180.200939] [041/133] (839s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-0-hflip)
[180.312108] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-0-hflip
[181.425337] Subtest x-tiled-max-hw-stride-32bpp-rotate-0-hflip: SUCCESS (1.114s)
[181.559967] [042/133] (838s left) gem_exec_schedule (preempt-other)
[181.638675] Starting subtest: preempt-other
[181.640771] Starting dynamic subtest: rcs0
[181.706728] Dynamic subtest rcs0: SUCCESS (0.071s)
[181.720736] Starting dynamic subtest: bcs0
[181.776525] Dynamic subtest bcs0: SUCCESS (0.069s)
[181.791120] Starting dynamic subtest: vcs0
[181.851105] Dynamic subtest vcs0: SUCCESS (0.075s)
[181.865789] Starting dynamic subtest: vcs1
[181.917956] Dynamic subtest vcs1: SUCCESS (0.066s)
[181.929154] Starting dynamic subtest: vecs0
[181.985207] Dynamic subtest vecs0: SUCCESS (0.066s)
[181.995550] Starting dynamic subtest: ccs0
[182.054652] Dynamic subtest ccs0: SUCCESS (0.068s)
[182.056691] Subtest preempt-other: SUCCESS (0.420s)
[183.306766] [043/133] (836s left) gem_exec_flush (basic-batch-kernel-default-uc)
[183.364171] Starting subtest: basic-batch-kernel-default-uc
[189.676436] Subtest basic-batch-kernel-default-uc: SUCCESS (6.309s)
[189.894521] [044/133] (830s left) api_intel_bb (object-reloc-keep-cache)
[189.950689] Starting subtest: object-reloc-keep-cache
[189.955855] Subtest object-reloc-keep-cache: SKIP (0.005s)
[190.076713] [045/133] (829s left) kms_psr (fbc-pr-sprite-render)
[190.176505] Starting subtest: fbc-pr-sprite-render
[190.181010] Subtest fbc-pr-sprite-render: SKIP (0.000s)
[190.247688] [046/133] (829s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-fullscreen)
[190.337050] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-fullscreen
[190.341580] Subtest fbcpsr-2p-scndscrn-spr-indfb-fullscreen: SKIP (0.000s)
[190.439154] [047/133] (829s left) gem_ctx_persistence (heartbeat-hang)
[190.495988] Starting subtest: heartbeat-hang
[190.500800] Subtest heartbeat-hang: SKIP (0.000s)
[190.604173] [048/133] (829s left) i915_module_load (reload-no-display)
[190.640222] Starting subtest: reload-no-display
[195.015115] Subtest reload-no-display: SUCCESS (4.373s)
[195.044419] [FACT i915_module_load (reload-no-display)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[195.045152] [FACT i915_module_load (reload-no-display)] deleted: kernel.kmod_is_loaded.i915: true
[195.048161] [049/133] (825s left) prime_self_import (reimport-vs-gem_close-race)
[195.095730] Starting subtest: reimport-vs-gem_close-race
[201.677850] Subtest reimport-vs-gem_close-race: SUCCESS (6.577s)
[201.714943] [FACT prime_self_import (reimport-vs-gem_close-race)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[201.716596] [FACT prime_self_import (reimport-vs-gem_close-race)] new: kernel.kmod_is_loaded.i915: true
[201.721140] [050/133] (818s left) gem_watchdog (default-virtual)
[201.791206] Starting subtest: default-virtual
[208.084160] Subtest default-virtual: SUCCESS (6.296s)
[208.170201] [051/133] (812s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-mmap-cpu)
[208.276348] Starting subtest: psr-1p-primscrn-pri-indfb-draw-mmap-cpu
[215.373733] Subtest psr-1p-primscrn-pri-indfb-draw-mmap-cpu: SUCCESS (7.097s)
[215.535545] [052/133] (804s left) sw_sync (sync_merge)
[215.568346] Starting subtest: sync_merge
[215.570874] Subtest sync_merge: SUCCESS (0.000s)
[215.630041] [053/133] (804s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-180-hflip)
[215.738428] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-180-hflip
[215.749891] Subtest yf-tiled-max-hw-stride-32bpp-rotate-180-hflip: SKIP (0.000s)
[215.841964] [054/133] (804s left) kms_color_pipeline (plane-lut1d-post-ctm3x4)
[215.946029] Starting subtest: plane-lut1d-post-ctm3x4
[216.094378] Starting dynamic subtest: pipe-A-plane-0
[216.259255] Dynamic subtest pipe-A-plane-0: SUCCESS (0.166s)
[216.273795] Starting dynamic subtest: pipe-A-plane-1
[216.447575] Dynamic subtest pipe-A-plane-1: SUCCESS (0.188s)
[216.455954] Starting dynamic subtest: pipe-A-plane-2
[216.613172] Dynamic subtest pipe-A-plane-2: SUCCESS (0.166s)
[217.822706] Starting dynamic subtest: pipe-B-plane-0
[218.001597] Dynamic subtest pipe-B-plane-0: SUCCESS (0.189s)
[218.017445] Starting dynamic subtest: pipe-B-plane-1
[218.192608] Dynamic subtest pipe-B-plane-1: SUCCESS (0.186s)
[218.201372] Starting dynamic subtest: pipe-B-plane-2
[218.379821] Dynamic subtest pipe-B-plane-2: SUCCESS (0.187s)
[219.639824] Starting dynamic subtest: pipe-C-plane-0
[219.787610] Dynamic subtest pipe-C-plane-0: SUCCESS (0.155s)
[219.797413] Starting dynamic subtest: pipe-C-plane-1
[219.954691] Dynamic subtest pipe-C-plane-1: SUCCESS (0.166s)
[219.963521] Starting dynamic subtest: pipe-C-plane-2
[220.110325] Dynamic subtest pipe-C-plane-2: SUCCESS (0.155s)
[221.367601] Starting dynamic subtest: pipe-D-plane-0
[221.516454] Dynamic subtest pipe-D-plane-0: SUCCESS (0.155s)
[221.525289] Starting dynamic subtest: pipe-D-plane-1
[221.660578] Dynamic subtest pipe-D-plane-1: SUCCESS (0.144s)
[221.669309] Starting dynamic subtest: pipe-D-plane-2
[221.816400] Dynamic subtest pipe-D-plane-2: SUCCESS (0.155s)
[222.103749] Subtest plane-lut1d-post-ctm3x4: SUCCESS (6.155s)
[222.926091] [055/133] (797s left) kms_big_fb (x-tiled-32bpp-rotate-0)
[223.053823] Starting subtest: x-tiled-32bpp-rotate-0
[224.545399] Subtest x-tiled-32bpp-rotate-0: SUCCESS (1.491s)
[224.679992] [056/133] (795s left) kms_pm_rpm (dpms-mode-unset-non-lpsp)
[226.420707] Starting subtest: dpms-mode-unset-non-lpsp
[227.567015] Subtest dpms-mode-unset-non-lpsp: SKIP (1.146s)
[227.939286] [057/133] (792s left) vgem_basic (second-client)
[227.988549] Starting subtest: second-client
[228.010806] Subtest second-client: SUCCESS (0.022s)
[228.071598] [058/133] (792s left) kms_psr2_su (page_flip-nv12)
[228.129666] Subtest page_flip-NV12: SKIP (0.000s)
[228.190987] [059/133] (792s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-blt)
[228.292022] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-blt
[232.528488] Subtest fbc-1p-offscreen-pri-indfb-draw-blt: SUCCESS (4.239s)
[233.731208] [060/133] (786s left) kms_ccs (bad-pixel-format-y-tiled-gen12-mc-ccs)
[233.833734] Starting subtest: bad-pixel-format-y-tiled-gen12-mc-ccs
[233.835990] Starting dynamic subtest: pipe-A-eDP-1
[233.857903] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[233.867951] Starting dynamic subtest: pipe-B-eDP-1
[233.889174] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[233.897769] Starting dynamic subtest: pipe-C-eDP-1
[233.918694] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[233.926963] Starting dynamic subtest: pipe-D-eDP-1
[233.949496] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[233.953635] Subtest bad-pixel-format-y-tiled-gen12-mc-ccs: SKIP (0.005s)
[236.092912] [061/133] (784s left) kms_plane (pixel-format-yf-tiled-modifier-source-clamping)
[236.191537] Starting subtest: pixel-format-yf-tiled-modifier-source-clamping
[236.195806] Subtest pixel-format-yf-tiled-modifier-source-clamping: SKIP (0.000s)
[236.278522] [062/133] (784s left) kms_cdclk (plane-scaling)
[236.371607] Starting subtest: plane-scaling
[236.373838] Starting dynamic subtest: pipe-A-eDP-1
[236.665312] Dynamic subtest pipe-A-eDP-1: SKIP (0.291s)
[236.674255] Starting dynamic subtest: pipe-B-eDP-1
[236.678648] Dynamic subtest pipe-B-eDP-1: SKIP (0.002s)
[236.686811] Starting dynamic subtest: pipe-C-eDP-1
[236.691153] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[236.699542] Starting dynamic subtest: pipe-D-eDP-1
[236.703867] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[236.707823] Subtest plane-scaling: SKIP (0.300s)
[237.512695] [063/133] (783s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-mmap-wc)
[237.609637] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-mmap-wc
[244.262668] Subtest psr-1p-offscreen-pri-shrfb-draw-mmap-wc: SUCCESS (6.661s)
[244.378248] [064/133] (776s left) kms_flip (blocking-wf_vblank)
[244.467751] Starting subtest: blocking-wf_vblank
[244.470052] Starting dynamic subtest: A-eDP1
[253.357525] Dynamic subtest A-eDP1: SUCCESS (8.913s)
[253.367204] Starting dynamic subtest: B-eDP1
[262.261386] Dynamic subtest B-eDP1: SUCCESS (8.917s)
[262.275405] Starting dynamic subtest: C-eDP1
[271.164514] Dynamic subtest C-eDP1: SUCCESS (8.909s)
[271.175199] Starting dynamic subtest: D-eDP1
[280.085241] Dynamic subtest D-eDP1: SUCCESS (8.921s)
[280.087702] Subtest blocking-wf_vblank: SUCCESS (35.670s)
[281.307519] [065/133] (739s left) kms_frontbuffer_tracking (fbc-2p-primscrn-shrfb-msflip-blt)
[281.403715] Starting subtest: fbc-2p-primscrn-shrfb-msflip-blt
[281.408063] Subtest fbc-2p-primscrn-shrfb-msflip-blt: SKIP (0.000s)
[281.497646] [066/133] (739s left) gem_ccs (block-copy-compressed)
[281.574673] Starting subtest: block-copy-compressed
[281.578752] Subtest block-copy-compressed: SKIP (0.000s)
[281.681713] [067/133] (739s left) gem_exec_fence (parallel)
[281.882545] Starting subtest: parallel
[281.885291] Starting dynamic subtest: rcs0
[284.031874] Dynamic subtest rcs0: SUCCESS (2.150s)
[284.042955] Starting dynamic subtest: bcs0
[286.181716] Dynamic subtest bcs0: SUCCESS (2.149s)
[286.192115] Starting dynamic subtest: vcs0
[288.331224] Dynamic subtest vcs0: SUCCESS (2.149s)
[288.341145] Starting dynamic subtest: vcs1
[290.490786] Dynamic subtest vcs1: SUCCESS (2.159s)
[290.501326] Starting dynamic subtest: vecs0
[292.640579] Dynamic subtest vecs0: SUCCESS (2.150s)
[292.648781] Starting dynamic subtest: ccs0
[294.790712] Dynamic subtest ccs0: SUCCESS (2.150s)
[294.792691] Subtest parallel: SUCCESS (12.912s)
[295.375608] [068/133] (725s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-mmap-gtt)
[295.492425] Starting subtest: psr-2p-primscrn-pri-indfb-draw-mmap-gtt
[295.496893] Subtest psr-2p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[295.582389] [069/133] (725s left) syncobj_timeline (invalid-query-zero-handles)
[295.635008] Starting subtest: invalid-query-zero-handles
[295.637382] Subtest invalid-query-zero-handles: SUCCESS (0.000s)
[295.718144] [070/133] (725s left) kms_vblank (query-idle-hang)
[295.816431] Starting subtest: query-idle-hang
[295.818744] Starting dynamic subtest: pipe-A-eDP-1
[321.992047] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.174s)
[322.007788] Starting dynamic subtest: pipe-D-eDP-1
[336.964684] Dynamic subtest pipe-D-eDP-1: SUCCESS (14.968s)
[336.966960] Subtest query-idle-hang: SUCCESS (41.147s)
[337.765770] [071/133] (683s left) kms_addfb_basic (basic-y-tiled-legacy)
[337.824371] Starting subtest: basic-y-tiled-legacy
[337.829437] Subtest basic-y-tiled-legacy: SKIP (0.000s)
[337.979547] [072/133] (683s left) kms_psr (pr-no-drrs)
[338.078019] Starting subtest: pr-no-drrs
[338.082225] Subtest pr-no-drrs: SKIP (0.000s)
[338.162835] [073/133] (682s left) gem_eio (in-flight-1us)
[338.383175] Starting subtest: in-flight-1us
[346.866971] Subtest in-flight-1us: SUCCESS (8.481s)
[347.045735] [074/133] (674s left) gem_partial_pwrite_pread (reads-uncached)
[347.098279] Subtest reads-uncached: SKIP (0.000s)
[347.169633] [075/133] (674s left) syncobj_wait (multi-wait-signaled)
[347.221533] Starting subtest: multi-wait-signaled
[347.223823] Subtest multi-wait-signaled: SUCCESS (0.000s)
[347.305881] [076/133] (673s left) kms_flip (2x-flip-vs-dpms)
[347.401885] Starting subtest: 2x-flip-vs-dpms
[347.413542] Subtest 2x-flip-vs-dpms: SKIP (0.011s)
[347.500090] [077/133] (673s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-mmap-gtt)
[347.602725] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-mmap-gtt
[347.606929] Subtest fbc-2p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[347.708996] [078/133] (673s left) gem_render_copy (yf-tiled-ccs-to-x-tiled)
[347.767873] Starting subtest: yf-tiled-ccs-to-x-tiled
[347.771390] Subtest yf-tiled-ccs-to-x-tiled: SKIP (0.000s)
[347.945507] [079/133] (673s left) syncobj_timeline (single-wait-available-signaled)
[347.998536] Starting subtest: single-wait-available-signaled
[348.000981] Subtest single-wait-available-signaled: SUCCESS (0.000s)
[348.107511] [080/133] (673s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-0)
[348.215440] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-0
[348.219988] Subtest y-tiled-max-hw-stride-32bpp-rotate-0: SKIP (0.000s)
[348.305205] [081/133] (673s left) i915_selftest (live)
[351.622465] Starting subtest: live
[351.625682] Starting dynamic subtest: sanitycheck
[355.955342] Dynamic subtest sanitycheck: SUCCESS (4.333s)
[355.964363] Starting dynamic subtest: uncore
[358.653206] Dynamic subtest uncore: SUCCESS (2.696s)
[358.662493] Starting dynamic subtest: workarounds
[361.792258] Dynamic subtest workarounds: SUCCESS (3.137s)
[361.802266] Starting dynamic subtest: gt_engines
[366.347977] Dynamic subtest gt_engines: SUCCESS (4.554s)
[366.362127] Starting dynamic subtest: gt_timelines
[384.118192] Dynamic subtest gt_timelines: SUCCESS (17.769s)
[384.127600] Starting dynamic subtest: gt_contexts
[388.461889] Dynamic subtest gt_contexts: SUCCESS (4.342s)
[388.477254] Starting dynamic subtest: gt_lrc
[392.823146] Dynamic subtest gt_lrc: SUCCESS (4.359s)
[392.833136] Starting dynamic subtest: gt_mocs
[397.328022] Dynamic subtest gt_mocs: SUCCESS (4.502s)
[397.338010] Starting dynamic subtest: gt_pm
[404.026987] Dynamic subtest gt_pm: SUCCESS (6.698s)
[404.036336] Starting dynamic subtest: gt_heartbeat
[406.707172] Dynamic subtest gt_heartbeat: SUCCESS (2.678s)
[406.716933] Starting dynamic subtest: gt_tlb
[416.058409] Dynamic subtest gt_tlb: SUCCESS (9.350s)
[416.068389] Starting dynamic subtest: requests
[429.627975] Dynamic subtest requests: SUCCESS (13.569s)
[429.641394] Starting dynamic subtest: migrate
[437.387868] Dynamic subtest migrate: SUCCESS (7.757s)
[437.399268] Starting dynamic subtest: active
[441.747718] Dynamic subtest active: SUCCESS (4.357s)
[441.755525] Starting dynamic subtest: objects
[446.494723] Dynamic subtest objects: SUCCESS (4.745s)
[446.504300] Starting dynamic subtest: mman
[449.761732] Dynamic subtest mman: SUCCESS (3.265s)
[449.770949] Starting dynamic subtest: dmabuf
[454.162615] Dynamic subtest dmabuf: SUCCESS (4.398s)
[454.172502] Starting dynamic subtest: vma
[458.547102] Dynamic subtest vma: SUCCESS (4.384s)
[458.557603] Starting dynamic subtest: coherency
[463.639381] Dynamic subtest coherency: SUCCESS (5.091s)
[463.654582] Starting dynamic subtest: gtt
[475.734432] Dynamic subtest gtt: SUCCESS (12.092s)
[475.744248] Starting dynamic subtest: gem
[481.876371] Dynamic subtest gem: SUCCESS (6.141s)
[481.885820] Starting dynamic subtest: evict
[485.857184] Dynamic subtest evict: SUCCESS (3.978s)
[485.867232] Starting dynamic subtest: hugepages
[494.663291] Dynamic subtest hugepages: SUCCESS (8.804s)
[494.673227] Starting dynamic subtest: gem_contexts
[521.246332] Dynamic subtest gem_contexts: SUCCESS (26.580s)
[521.256299] Starting dynamic subtest: client
[523.986382] Dynamic subtest client: SUCCESS (2.739s)
[523.999222] Starting dynamic subtest: gem_migrate
[528.317665] Dynamic subtest gem_migrate: SUCCESS (4.330s)
[528.327508] Starting dynamic subtest: reset
[532.656683] Dynamic subtest reset: SUCCESS (4.337s)
[532.669881] Starting dynamic subtest: memory_region
[536.990572] Dynamic subtest memory_region: SUCCESS (4.333s)
[537.000160] Starting dynamic subtest: hangcheck
[550.295932] Dynamic subtest hangcheck: SUCCESS (13.303s)
[550.310377] Starting dynamic subtest: execlists
[554.569665] Dynamic subtest execlists: SUCCESS (4.272s)
[554.579707] Starting dynamic subtest: ring_submission
[558.901795] Dynamic subtest ring_submission: SUCCESS (4.331s)
[558.911418] Starting dynamic subtest: perf
[563.224817] Dynamic subtest perf: SUCCESS (4.321s)
[563.232836] Starting dynamic subtest: slpc
[577.304612] Dynamic subtest slpc: SUCCESS (14.077s)
[577.313593] Starting dynamic subtest: guc
[581.271679] Dynamic subtest guc: SUCCESS (3.965s)
[581.281132] Starting dynamic subtest: guc_multi_lrc
[585.627504] Dynamic subtest guc_multi_lrc: SUCCESS (4.354s)
[585.637050] Starting dynamic subtest: guc_hang
[590.528823] Dynamic subtest guc_hang: SUCCESS (4.899s)
[590.538448] Starting dynamic subtest: late_gt_pm
[594.841688] Dynamic subtest late_gt_pm: SUCCESS (4.311s)
[594.844659] Subtest live: SUCCESS (243.212s)
[594.875518] [FACT i915_selftest (live)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[594.876232] [FACT i915_selftest (live)] deleted: kernel.kmod_is_loaded.i915: true
[594.879570] [082/133] (426s left) gem_exec_fence (basic-wait)
[596.537179] Starting subtest: basic-wait
[596.539426] Starting dynamic subtest: rcs0
[596.604120] Dynamic subtest rcs0: SUCCESS (0.069s)
[596.615346] Starting dynamic subtest: bcs0
[596.657695] Dynamic subtest bcs0: SUCCESS (0.051s)
[596.668247] Starting dynamic subtest: vcs0
[596.711181] Dynamic subtest vcs0: SUCCESS (0.051s)
[596.722088] Starting dynamic subtest: vcs1
[596.766407] Dynamic subtest vcs1: SUCCESS (0.053s)
[596.776665] Starting dynamic subtest: vecs0
[596.822063] Dynamic subtest vecs0: SUCCESS (0.054s)
[596.832523] Starting dynamic subtest: ccs0
[596.874561] Dynamic subtest ccs0: SUCCESS (0.049s)
[596.877566] Subtest basic-wait: SUCCESS (0.340s)
[598.257170] [FACT gem_exec_fence (basic-wait)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[598.258841] [FACT gem_exec_fence (basic-wait)] new: kernel.kmod_is_loaded.i915: true
[598.262680] [083/133] (423s left) syncobj_timeline (multi-wait-available-unsubmitted-submitted-signaled)
[598.325693] Starting subtest: multi-wait-available-unsubmitted-submitted-signaled
[598.328245] Subtest multi-wait-available-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[598.442800] [084/133] (423s left) kms_chamelium_edid (dp-mode-timings)
[598.830435] Subtest dp-mode-timings: SKIP (0.000s)
[599.604611] [085/133] (422s left) gem_exec_reloc (basic-concurrent0)
[599.668801] Subtest basic-concurrent0: SKIP (0.000s)
[599.740877] [086/133] (421s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-shrfb-msflip-blt)
[599.844135] Starting subtest: fbcpsr-2p-primscrn-shrfb-msflip-blt
[599.848208] Subtest fbcpsr-2p-primscrn-shrfb-msflip-blt: SKIP (0.000s)
[599.933520] [087/133] (421s left) gem_softpin (evict-snoop)
[599.997082] Starting subtest: evict-snoop
[600.000935] Subtest evict-snoop: SKIP (0.000s)
[600.100244] [088/133] (421s left) kms_flip (basic-flip-vs-modeset)
[600.198765] Starting subtest: basic-flip-vs-modeset
[600.200669] Starting dynamic subtest: A-eDP1
[602.757720] Dynamic subtest A-eDP1: SUCCESS (2.559s)
[602.766924] Starting dynamic subtest: B-eDP1
[604.923067] Dynamic subtest B-eDP1: SUCCESS (2.165s)
[604.934408] Starting dynamic subtest: C-eDP1
[607.095249] Dynamic subtest C-eDP1: SUCCESS (2.171s)
[607.107260] Starting dynamic subtest: D-eDP1
[609.262923] Dynamic subtest D-eDP1: SUCCESS (2.165s)
[609.265050] Subtest basic-flip-vs-modeset: SUCCESS (9.069s)
[610.059775] [089/133] (411s left) kms_plane_alpha_blend (constant-alpha-mid)
[610.156402] Starting subtest: constant-alpha-mid
[610.461376] Starting dynamic subtest: pipe-A-eDP-1
[611.430537] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.967s)
[611.439827] Starting dynamic subtest: pipe-D-eDP-1
[613.000952] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.568s)
[613.003121] Subtest constant-alpha-mid: SUCCESS (2.844s)
[613.816119] [090/133] (408s left) kms_lease (lessee-list)
[613.905804] Starting subtest: lessee-list
[613.908107] Starting dynamic subtest: pipe-A-eDP-1
[613.910345] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.002s)
[613.919567] Starting dynamic subtest: pipe-B-eDP-1
[613.921730] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[613.930859] Starting dynamic subtest: pipe-C-eDP-1
[613.933054] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[613.941255] Starting dynamic subtest: pipe-D-eDP-1
[613.943453] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[613.945705] Subtest lessee-list: SUCCESS (0.009s)
[614.009021] [091/133] (407s left) gem_mmap_offset (partial-remap)
[614.061776] Starting subtest: partial-remap
[614.064011] Starting dynamic subtest: smem0
[614.072699] Dynamic subtest smem0: SUCCESS (0.005s)
[614.074659] Subtest partial-remap: SUCCESS (0.006s)
[614.182689] [092/133] (407s left) kms_ccs (crc-primary-basic-4-tiled-dg2-rc-ccs-cc)
[614.278671] Starting subtest: crc-primary-basic-4-tiled-dg2-rc-ccs-cc
[614.280921] Starting dynamic subtest: pipe-A-eDP-1
[614.303467] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[614.315991] Starting dynamic subtest: pipe-B-eDP-1
[614.336641] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[614.345672] Starting dynamic subtest: pipe-C-eDP-1
[614.366110] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[614.374245] Starting dynamic subtest: pipe-D-eDP-1
[614.395340] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[614.399217] Subtest crc-primary-basic-4-tiled-dg2-rc-ccs-cc: SKIP (0.006s)
[616.604618] [093/133] (405s left) kms_universal_plane (universal-plane-sanity)
[616.695378] Starting subtest: universal-plane-sanity
[616.697693] Starting dynamic subtest: pipe-A-eDP-1
[617.299304] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.602s)
[617.308384] Starting dynamic subtest: pipe-B-eDP-1
[618.520250] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.220s)
[618.529386] Starting dynamic subtest: pipe-C-eDP-1
[619.730998] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.210s)
[619.740426] Starting dynamic subtest: pipe-D-eDP-1
[620.960469] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.225s)
[620.962688] Subtest universal-plane-sanity: SUCCESS (4.263s)
[621.817141] [094/133] (400s left) kms_cursor_crc (cursor-offscreen-64x21)
[622.029353] Starting subtest: cursor-offscreen-64x21
[622.099935] Subtest cursor-offscreen-64x21: SKIP (0.067s)
[622.319773] [095/133] (399s left) perf (oa-exponents)
[622.438586] Starting subtest: oa-exponents
[622.440864] Starting dynamic subtest: 0-rcs0
[624.208381] Dynamic subtest 0-rcs0: SUCCESS (1.770s)
[624.218693] Starting dynamic subtest: 1-vecs0
[626.039119] Dynamic subtest 1-vecs0: SUCCESS (1.830s)
[626.041655] Subtest oa-exponents: SUCCESS (3.602s)
[626.091745] [096/133] (395s left) gem_create (busy-create)
[626.149348] Starting subtest: busy-create
[626.151721] Starting dynamic subtest: smem0
[660.159092] Dynamic subtest smem0: SUCCESS (34.007s)
[660.161905] Subtest busy-create: SUCCESS (34.009s)
[660.348606] [097/133] (361s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-render)
[660.465393] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-render
[660.469655] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-render: SKIP (0.000s)
[660.555436] [098/133] (361s left) kms_prop_blob (blob-prop-core)
[660.603326] Starting subtest: blob-prop-core
[660.605560] Subtest blob-prop-core: SUCCESS (0.000s)
[660.692460] [099/133] (361s left) kms_cursor_crc (cursor-random-128x128)
[660.903434] Starting subtest: cursor-random-128x128
[660.905685] Starting dynamic subtest: pipe-A-eDP-1
[664.270505] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.364s)
[664.299561] Starting dynamic subtest: pipe-D-eDP-1
[668.324249] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.033s)
[668.326687] Subtest cursor-random-128x128: SUCCESS (7.423s)
[669.175846] [100/133] (353s left) kms_big_fb (4-tiled-32bpp-rotate-90)
[669.279549] Starting subtest: 4-tiled-32bpp-rotate-90
[669.299244] Subtest 4-tiled-32bpp-rotate-90: SKIP (0.019s)
[669.414456] [101/133] (352s left) kms_cursor_crc (cursor-tearing-framebuffer-change)
[669.530376] Starting subtest: cursor-tearing-framebuffer-change
[669.532675] Starting dynamic subtest: pipe-A-eDP-1
[670.097282] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.566s)
[670.112885] Starting dynamic subtest: pipe-D-eDP-1
[671.320840] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.219s)
[671.323042] Subtest cursor-tearing-framebuffer-change: SUCCESS (1.788s)
[672.144391] [102/133] (350s left) gem_exec_whisper (basic-forked-all)
[672.211514] Starting subtest: basic-forked-all
[686.202001] Subtest basic-forked-all: SUCCESS (13.989s)
[686.393037] [103/133] (335s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-indfb-plflip-blt)
[686.488793] Starting subtest: fbcpsr-2p-scndscrn-indfb-plflip-blt
[686.492773] Subtest fbcpsr-2p-scndscrn-indfb-plflip-blt: SKIP (0.000s)
[686.583306] [104/133] (335s left) kms_psr (fbc-psr2-sprite-mmap-gtt)
[686.675071] Starting subtest: fbc-psr2-sprite-mmap-gtt
[686.677383] Starting dynamic subtest: eDP-1
[686.681687] Dynamic subtest eDP-1: SKIP (0.000s)
[686.685907] Subtest fbc-psr2-sprite-mmap-gtt: SKIP (0.001s)
[686.748604] [105/133] (335s left) kms_plane_scaling (plane-upscale-factor-0-25-with-pixel-format)
[686.845403] Starting subtest: plane-upscale-factor-0-25-with-pixel-format
[686.847700] Starting dynamic subtest: pipe-A
[687.894492] Dynamic subtest pipe-A: SUCCESS (1.050s)
[687.903860] Starting dynamic subtest: pipe-B
[690.075206] Dynamic subtest pipe-B: SUCCESS (2.179s)
[690.086556] Starting dynamic subtest: pipe-C
[691.250329] Dynamic subtest pipe-C: SUCCESS (1.174s)
[691.261539] Starting dynamic subtest: pipe-D
[692.482906] Dynamic subtest pipe-D: SUCCESS (1.231s)
[692.485351] Subtest plane-upscale-factor-0-25-with-pixel-format: SUCCESS (5.640s)
[693.671429] [106/133] (328s left) perf_pmu (rc6-suspend)
[693.718944] Starting subtest: rc6-suspend
[715.930124] Subtest rc6-suspend: SUCCESS (7.503s)
[716.827909] [107/133] (305s left) gem_ctx_param (invalid-get-no-zeromap)
[716.889539] Starting subtest: invalid-get-no-zeromap
[716.891760] Subtest invalid-get-no-zeromap: SUCCESS (0.001s)
[716.998910] [108/133] (305s left) kms_chamelium_hpd (hdmi-hpd-after-suspend)
[717.396872] Subtest hdmi-hpd-after-suspend: SKIP (0.000s)
[718.160620] [109/133] (304s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-onoff)
[718.253033] Starting subtest: psr-2p-primscrn-cur-indfb-onoff
[718.257461] Subtest psr-2p-primscrn-cur-indfb-onoff: SKIP (0.000s)
[718.353042] [110/133] (304s left) gem_lmem_swapping (parallel-random-verify)
[718.402197] Subtest parallel-random-verify: SKIP (0.000s)
[718.453007] [111/133] (304s left) gem_mmap_wc (set-cache-level)
[718.513033] Subtest set-cache-level: SKIP (0.000s)
[718.574789] [112/133] (304s left) sysfs_timeslice_duration (idempotent)
[718.640828] Starting subtest: idempotent
[718.643095] Starting dynamic subtest: vecs0
[718.645427] Dynamic subtest vecs0: SUCCESS (0.000s)
[718.655811] Starting dynamic subtest: ccs0
[718.657694] Dynamic subtest ccs0: SUCCESS (0.000s)
[718.666765] Starting dynamic subtest: vcs0
[718.668687] Dynamic subtest vcs0: SUCCESS (0.000s)
[718.677645] Starting dynamic subtest: bcs0
[718.680050] Dynamic subtest bcs0: SUCCESS (0.000s)
[718.689239] Starting dynamic subtest: rcs0
[718.691132] Dynamic subtest rcs0: SUCCESS (0.000s)
[718.702265] Starting dynamic subtest: vcs1
[718.704451] Dynamic subtest vcs1: SUCCESS (0.000s)
[718.706698] Subtest idempotent: SUCCESS (0.007s)
[718.743835] [113/133] (304s left) kms_cursor_legacy (cursorb-vs-flipa-atomic-transitions-varying-size)
[718.865028] Starting subtest: cursorB-vs-flipA-atomic-transitions-varying-size
[718.869612] Subtest cursorB-vs-flipA-atomic-transitions-varying-size: SKIP (0.002s)
[719.013527] [114/133] (303s left) gem_exec_schedule (u-semaphore-codependency)
[719.089470] Starting subtest: u-semaphore-codependency
[719.095100] Subtest u-semaphore-codependency: SUCCESS (0.013s)
[719.431834] [115/133] (303s left) syncobj_wait (signal)
[719.492269] Starting subtest: signal
[719.494717] Subtest signal: SUCCESS (0.000s)
[719.604913] [116/133] (303s left) kms_flip (2x-flip-vs-rmfb)
[719.693288] Starting subtest: 2x-flip-vs-rmfb
[719.701570] Subtest 2x-flip-vs-rmfb: SKIP (0.011s)
[719.780250] [117/133] (303s left) kms_psr (psr2-cursor-render)
[719.883226] Starting subtest: psr2-cursor-render
[719.885588] Starting dynamic subtest: eDP-1
[721.583546] Dynamic subtest eDP-1: SUCCESS (1.698s)
[721.585729] Subtest psr2-cursor-render: SUCCESS (1.699s)
[722.381066] [118/133] (300s left) kms_addfb_basic (basic)
[722.441408] Starting subtest: basic
[722.443946] Subtest basic: SUCCESS (0.000s)
[722.586075] [119/133] (300s left) kms_cursor_legacy (short-flip-after-cursor-atomic-transitions-varying-size)
[722.713918] Starting subtest: short-flip-after-cursor-atomic-transitions-varying-size
[723.692635] Subtest short-flip-after-cursor-atomic-transitions-varying-size: SUCCESS (0.977s)
[724.510806] [120/133] (298s left) kms_psr2_sf (psr2-cursor-plane-move-continuous-exceed-fully-sf)
[724.605481] Starting subtest: psr2-cursor-plane-move-continuous-exceed-fully-sf
[724.607802] Starting dynamic subtest: pipe-A-eDP-1
[735.594184] Dynamic subtest pipe-A-eDP-1: SUCCESS (10.981s)
[735.604603] Starting dynamic subtest: pipe-B-eDP-1
[747.322282] Dynamic subtest pipe-B-eDP-1: SUCCESS (11.723s)
[747.324767] Subtest psr2-cursor-plane-move-continuous-exceed-fully-sf: SUCCESS (22.707s)
[748.190458] [121/133] (274s left) i915_drm_fdinfo (memory-info-purgeable)
[748.244369] Starting subtest: memory-info-purgeable
[748.246731] Starting dynamic subtest: smem0
[751.217341] Dynamic subtest smem0: SUCCESS (2.974s)
[751.220177] Subtest memory-info-purgeable: SUCCESS (2.975s)
[751.303772] [122/133] (271s left) kms_dsc (dsc-with-bpc)
[751.394974] Starting subtest: dsc-with-bpc
[751.420817] Subtest dsc-with-bpc: SKIP (0.001s)
[751.479974] [123/133] (271s left) kms_flip (2x-single-buffer-flip-vs-dpms-off-vs-modeset)
[751.568623] Starting subtest: 2x-single-buffer-flip-vs-dpms-off-vs-modeset
[751.578474] Subtest 2x-single-buffer-flip-vs-dpms-off-vs-modeset: SKIP (0.011s)
[751.661627] [124/133] (271s left) gem_exec_params (sol-reset-not-gen7)
[751.723845] Starting subtest: sol-reset-not-gen7
[751.728536] Subtest sol-reset-not-gen7: SUCCESS (0.003s)
[751.838518] [125/133] (271s left) kms_plane_scaling (plane-downscale-factor-0-75-with-modifiers)
[751.943560] Starting subtest: plane-downscale-factor-0-75-with-modifiers
[751.945411] Starting dynamic subtest: pipe-A
[752.320173] Dynamic subtest pipe-A: SUCCESS (0.376s)
[752.330574] Starting dynamic subtest: pipe-B
[753.773645] Dynamic subtest pipe-B: SUCCESS (1.452s)
[753.784323] Starting dynamic subtest: pipe-C
[755.231618] Dynamic subtest pipe-C: SUCCESS (1.458s)
[755.241463] Starting dynamic subtest: pipe-D
[756.643964] Dynamic subtest pipe-D: SUCCESS (1.411s)
[756.646211] Subtest plane-downscale-factor-0-75-with-modifiers: SUCCESS (4.702s)
[757.812644] [126/133] (265s left) i915_query (query-topology-coherent-slice-mask)
[757.872387] Starting subtest: query-topology-coherent-slice-mask
[757.876897] Subtest query-topology-coherent-slice-mask: SKIP (0.000s)
[757.986760] [127/133] (265s left) kms_frontbuffer_tracking (psr-rgb101010-draw-mmap-wc)
[758.082522] Starting subtest: psr-rgb101010-draw-mmap-wc
[765.181548] Subtest psr-rgb101010-draw-mmap-wc: SUCCESS (7.102s)
[765.297003] [128/133] (258s left) gem_ringfill (engines-basic)
[770.916993] Starting subtest: engines-basic
[770.919680] Starting dynamic subtest: rcs0
[770.968583] Dynamic subtest rcs0: SUCCESS (0.052s)
[770.981258] Starting dynamic subtest: bcs0
[771.012584] Dynamic subtest bcs0: SUCCESS (0.042s)
[771.023405] Starting dynamic subtest: vcs0
[771.055725] Dynamic subtest vcs0: SUCCESS (0.041s)
[771.066643] Starting dynamic subtest: vcs1
[771.098698] Dynamic subtest vcs1: SUCCESS (0.041s)
[771.109461] Starting dynamic subtest: vecs0
[771.142493] Dynamic subtest vecs0: SUCCESS (0.042s)
[771.153351] Starting dynamic subtest: ccs0
[771.187519] Dynamic subtest ccs0: SUCCESS (0.043s)
[771.189890] Subtest engines-basic: SUCCESS (0.273s)
[771.265430] [129/133] (252s left) kms_atomic (plane-primary-overlay-mutable-zpos)
[771.368029] Starting subtest: plane-primary-overlay-mutable-zpos
[774.788042] Subtest plane-primary-overlay-mutable-zpos: SKIP (3.419s)
[775.978513] [130/133] (247s left) kms_flip_scaled_crc (flip-64bpp-linear-to-16bpp-linear-upscaling)
[776.080720] Starting subtest: flip-64bpp-linear-to-16bpp-linear-upscaling
[776.083132] Starting dynamic subtest: pipe-A-default-mode
[778.829130] Dynamic subtest pipe-A-default-mode: SUCCESS (2.748s)
[778.831641] Subtest flip-64bpp-linear-to-16bpp-linear-upscaling: SUCCESS (2.750s)
[779.672111] [131/133] (243s left) gem_spin_batch (legacy)
[779.741879] Starting subtest: legacy
[779.743839] Starting dynamic subtest: default
[782.981161] Dynamic subtest default: SUCCESS (3.235s)
[782.992890] Starting dynamic subtest: render
[786.216552] Dynamic subtest render: SUCCESS (3.232s)
[786.228021] Starting dynamic subtest: bsd
[789.455601] Dynamic subtest bsd: SUCCESS (3.234s)
[789.467162] Starting dynamic subtest: bsd1
[792.690874] Dynamic subtest bsd1: SUCCESS (3.231s)
[792.701814] Starting dynamic subtest: bsd2
[795.929713] Dynamic subtest bsd2: SUCCESS (3.235s)
[795.941214] Starting dynamic subtest: blt
[799.166691] Dynamic subtest blt: SUCCESS (3.233s)
[799.178719] Starting dynamic subtest: vebox
[802.402998] Dynamic subtest vebox: SUCCESS (3.232s)
[802.405634] Subtest legacy: SUCCESS (22.654s)
[803.001787] [132/133] (220s left) core_setmaster (master-drop-set-shared-fd)
[803.081780] Starting subtest: master-drop-set-shared-fd
[803.100008] Subtest master-drop-set-shared-fd: SUCCESS (0.021s)
[803.139846] [133/133] (220s left) syncobj_timeline (etime-single-wait-all-for-submit-submitted)
[803.196961] Starting subtest: etime-single-wait-all-for-submit-submitted
[803.302270] Subtest etime-single-wait-all-for-submit-submitted: SUCCESS (0.105s)
[803.379948] Closing watchdogs
results: parsing output: 0/ for test: gem_userptr_blits
results: parsing output: 1/ for test: gem_exec_params
results: parsing output: 2/ for test: kms_setmode
results: parsing output: 3/ for test: kms_ccs
results: parsing output: 4/ for test: gem_gtt_cpu_tlb
results: parsing output: 5/ for test: testdisplay
results: parsing output: 6/ for test: vgem_basic
results: parsing output: 7/ for test: kms_frontbuffer_tracking
results: parsing output: 8/ for test: i915_pm_rps
results: parsing output: 9/ for test: kms_dither
results: parsing output: 10/ for test: gem_sync
results: parsing output: 11/ for test: kms_flip
results: parsing output: 12/ for test: sw_sync
results: parsing output: 13/ for test: syncobj_timeline
results: parsing output: 14/ for test: kms_vrr
results: parsing output: 15/ for test: gem_exec_balancer
results: parsing output: 16/ for test: gem_ctx_shared
results: parsing output: 17/ for test: kms_frontbuffer_tracking
results: parsing output: 18/ for test: gem_pxp
results: parsing output: 19/ for test: kms_frontbuffer_tracking
results: parsing output: 20/ for test: kms_content_protection
results: parsing output: 21/ for test: gem_mmap_gtt
results: parsing output: 22/ for test: kms_frontbuffer_tracking
results: parsing output: 23/ for test: kms_joiner
results: parsing output: 24/ for test: gen9_exec_parse
results: parsing output: 25/ for test: kms_plane_multiple
results: parsing output: 26/ for test: kms_psr
results: parsing output: 27/ for test: kms_frontbuffer_tracking
results: parsing output: 28/ for test: tools_test
results: parsing output: 29/ for test: kms_pm_rpm
results: parsing output: 30/ for test: kms_big_fb
results: parsing output: 31/ for test: kms_frontbuffer_tracking
results: parsing output: 32/ for test: kms_cursor_legacy
results: parsing output: 33/ for test: gem_eio
results: parsing output: 34/ for test: kms_frontbuffer_tracking
results: parsing output: 35/ for test: kms_ccs
results: parsing output: 36/ for test: prime_busy
results: parsing output: 37/ for test: kms_big_fb
results: parsing output: 38/ for test: api_intel_allocator
results: parsing output: 39/ for test: gem_gpgpu_fill
results: parsing output: 40/ for test: kms_big_fb
results: parsing output: 41/ for test: gem_exec_schedule
results: parsing output: 42/ for test: gem_exec_flush
results: parsing output: 43/ for test: api_intel_bb
results: parsing output: 44/ for test: kms_psr
results: parsing output: 45/ for test: kms_frontbuffer_tracking
results: parsing output: 46/ for test: gem_ctx_persistence
results: parsing output: 47/ for test: i915_module_load
results: parsing output: 48/ for test: prime_self_import
results: parsing output: 49/ for test: gem_watchdog
results: parsing output: 50/ for test: kms_frontbuffer_tracking
results: parsing output: 51/ for test: sw_sync
results: parsing output: 52/ for test: kms_big_fb
results: parsing output: 53/ for test: kms_color_pipeline
results: parsing output: 54/ for test: kms_big_fb
results: parsing output: 55/ for test: kms_pm_rpm
results: parsing output: 56/ for test: vgem_basic
results: parsing output: 57/ for test: kms_psr2_su
results: parsing output: 58/ for test: kms_frontbuffer_tracking
results: parsing output: 59/ for test: kms_ccs
results: parsing output: 60/ for test: kms_plane
results: parsing output: 61/ for test: kms_cdclk
results: parsing output: 62/ for test: kms_frontbuffer_tracking
results: parsing output: 63/ for test: kms_flip
results: parsing output: 64/ for test: kms_frontbuffer_tracking
results: parsing output: 65/ for test: gem_ccs
results: parsing output: 66/ for test: gem_exec_fence
results: parsing output: 67/ for test: kms_frontbuffer_tracking
results: parsing output: 68/ for test: syncobj_timeline
results: parsing output: 69/ for test: kms_vblank
results: parsing output: 70/ for test: kms_addfb_basic
results: parsing output: 71/ for test: kms_psr
results: parsing output: 72/ for test: gem_eio
results: parsing output: 73/ for test: gem_partial_pwrite_pread
results: parsing output: 74/ for test: syncobj_wait
results: parsing output: 75/ for test: kms_flip
results: parsing output: 76/ for test: kms_frontbuffer_tracking
results: parsing output: 77/ for test: gem_render_copy
results: parsing output: 78/ for test: syncobj_timeline
results: parsing output: 79/ for test: kms_big_fb
results: parsing output: 80/ for test: i915_selftest
results: parsing output: 81/ for test: gem_exec_fence
results: parsing output: 82/ for test: syncobj_timeline
results: parsing output: 83/ for test: kms_chamelium_edid
results: parsing output: 84/ for test: gem_exec_reloc
results: parsing output: 85/ for test: kms_frontbuffer_tracking
results: parsing output: 86/ for test: gem_softpin
results: parsing output: 87/ for test: kms_flip
results: parsing output: 88/ for test: kms_plane_alpha_blend
results: parsing output: 89/ for test: kms_lease
results: parsing output: 90/ for test: gem_mmap_offset
results: parsing output: 91/ for test: kms_ccs
results: parsing output: 92/ for test: kms_universal_plane
results: parsing output: 93/ for test: kms_cursor_crc
results: parsing output: 94/ for test: perf
results: parsing output: 95/ for test: gem_create
results: parsing output: 96/ for test: kms_frontbuffer_tracking
results: parsing output: 97/ for test: kms_prop_blob
results: parsing output: 98/ for test: kms_cursor_crc
results: parsing output: 99/ for test: kms_big_fb
results: parsing output: 100/ for test: kms_cursor_crc
results: parsing output: 101/ for test: gem_exec_whisper
results: parsing output: 102/ for test: kms_frontbuffer_tracking
results: parsing output: 103/ for test: kms_psr
results: parsing output: 104/ for test: kms_plane_scaling
results: parsing output: 105/ for test: perf_pmu
results: parsing output: 106/ for test: gem_ctx_param
results: parsing output: 107/ for test: kms_chamelium_hpd
results: parsing output: 108/ for test: kms_frontbuffer_tracking
results: parsing output: 109/ for test: gem_lmem_swapping
results: parsing output: 110/ for test: gem_mmap_wc
results: parsing output: 111/ for test: sysfs_timeslice_duration
results: parsing output: 112/ for test: kms_cursor_legacy
results: parsing output: 113/ for test: gem_exec_schedule
results: parsing output: 114/ for test: syncobj_wait
results: parsing output: 115/ for test: kms_flip
results: parsing output: 116/ for test: kms_psr
results: parsing output: 117/ for test: kms_addfb_basic
results: parsing output: 118/ for test: kms_cursor_legacy
results: parsing output: 119/ for test: kms_psr2_sf
results: parsing output: 120/ for test: i915_drm_fdinfo
results: parsing output: 121/ for test: kms_dsc
results: parsing output: 122/ for test: kms_flip
results: parsing output: 123/ for test: gem_exec_params
results: parsing output: 124/ for test: kms_plane_scaling
results: parsing output: 125/ for test: i915_query
results: parsing output: 126/ for test: kms_frontbuffer_tracking
results: parsing output: 127/ for test: gem_ringfill
results: parsing output: 128/ for test: kms_atomic
results: parsing output: 129/ for test: kms_flip_scaled_crc
results: parsing output: 130/ for test: gem_spin_batch
results: parsing output: 131/ for test: core_setmaster
results: parsing output: 132/ for test: syncobj_timeline
Done.