[58.071024] Initializing watchdogs
[58.071072]   /dev/watchdog0
[58.085089] [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]
[58.089331] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[58.091988] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[58.095384] [001/133] (960s left) gem_mmap_gtt (big-copy)
[58.164620] Subtest big-copy: SKIP (0.000s)
[58.230399] [002/133] (960s left) gem_softpin (evict-single-offset)
[58.291094] Starting subtest: evict-single-offset
[86.935080] Subtest evict-single-offset: SUCCESS (28.641s)
[87.031312] [003/133] (931s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-render)
[87.183823] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-render
[87.187815] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-render: SKIP (0.000s)
[87.287729] [004/133] (931s left) syncobj_timeline (multi-wait-all-available-submitted)
[87.355590] Starting subtest: multi-wait-all-available-submitted
[87.358057] Subtest multi-wait-all-available-submitted: SUCCESS (0.001s)
[87.460528] [005/133] (931s left) api_intel_allocator (reopen)
[87.515855] Starting subtest: reopen
[87.518287] Subtest reopen: SUCCESS (0.004s)
[87.639943] [006/133] (931s left) kms_big_fb (4-tiled-16bpp-rotate-270)
[87.736058] Starting subtest: 4-tiled-16bpp-rotate-270
[87.769435] Subtest 4-tiled-16bpp-rotate-270: SKIP (0.031s)
[87.874950] [007/133] (930s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-mmap-gtt)
[87.968748] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-mmap-gtt
[87.972300] Subtest fbc-2p-scndscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[88.069863] [008/133] (930s left) kms_cursor_legacy (cursorb-vs-flipb-varying-size)
[88.189332] Starting subtest: cursorB-vs-flipB-varying-size
[88.193087] Subtest cursorB-vs-flipB-varying-size: SKIP (0.001s)
[88.343754] [009/133] (930s left) i915_pm_rps (thresholds-idle)
[88.403804] Starting subtest: thresholds-idle
[88.407577] Subtest thresholds-idle: SKIP (0.000s)
[88.498360] [010/133] (930s left) kms_ccs (ccs-on-another-bo-4-tiled-mtl-rc-ccs)
[88.608430] Starting subtest: ccs-on-another-bo-4-tiled-mtl-rc-ccs
[88.610307] Starting dynamic subtest: pipe-A-eDP-1
[88.627427] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[88.636156] Starting dynamic subtest: pipe-B-eDP-1
[88.652566] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[88.659156] Starting dynamic subtest: pipe-C-eDP-1
[88.674779] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[88.681395] Starting dynamic subtest: pipe-D-eDP-1
[88.697179] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[88.698729] Subtest ccs-on-another-bo-4-tiled-mtl-rc-ccs: SUCCESS (0.007s)
[90.916415] [011/133] (928s left) syncobj_eventfd (invalid-bad-pad)
[90.973925] Starting subtest: invalid-bad-pad
[90.975945] Subtest invalid-bad-pad: SUCCESS (0.000s)
[91.065219] [012/133] (927s left) i915_drm_fdinfo (memory-info-resident)
[91.110045] Starting subtest: memory-info-resident
[91.112308] Starting dynamic subtest: smem0
[93.958443] Dynamic subtest smem0: SUCCESS (2.850s)
[93.960759] Subtest memory-info-resident: SUCCESS (2.850s)
[94.026635] [013/133] (925s left) syncobj_wait (multi-wait-all-submitted-signaled)
[94.094083] Starting subtest: multi-wait-all-submitted-signaled
[94.202857] Subtest multi-wait-all-submitted-signaled: SUCCESS (0.106s)
[94.275117] [014/133] (924s left) i915_module_load (resize-bar)
[94.311584] Starting subtest: resize-bar
[94.321070] Subtest resize-bar: SKIP (0.007s)
[94.361701] [015/133] (924s left) syncobj_timeline (wait-all-for-submit-delayed-submit)
[94.415964] Starting subtest: wait-all-for-submit-delayed-submit
[94.519435] Subtest wait-all-for-submit-delayed-submit: SUCCESS (0.104s)
[94.604845] [016/133] (924s left) kms_ccs (crc-sprite-planes-basic-yf-tiled-ccs)
[94.696428] Starting subtest: crc-sprite-planes-basic-yf-tiled-ccs
[94.698769] Starting dynamic subtest: pipe-A-eDP-1
[94.756904] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[94.763849] Starting dynamic subtest: pipe-B-eDP-1
[94.820766] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[94.829903] Starting dynamic subtest: pipe-C-eDP-1
[94.885884] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[94.894243] Starting dynamic subtest: pipe-D-eDP-1
[94.951470] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[94.955815] Subtest crc-sprite-planes-basic-yf-tiled-ccs: SKIP (0.007s)
[96.971738] [017/133] (922s left) gem_sync (basic-store-all)
[97.053688] Starting subtest: basic-store-all
[99.756805] Subtest basic-store-all: SUCCESS (2.715s)
[99.941782] [018/133] (919s left) kms_psr (psr-dpms)
[100.050727] Starting subtest: psr-dpms
[100.053057] Starting dynamic subtest: eDP-1
[103.019703] Dynamic subtest eDP-1: SUCCESS (2.969s)
[103.022062] Subtest psr-dpms: SUCCESS (2.969s)
[103.884506] [019/133] (915s left) kms_content_protection (dp-mst-type-0)
[104.022964] Starting subtest: dp-mst-type-0
[104.027742] Subtest dp-mst-type-0: SKIP (0.000s)
[104.168325] [020/133] (915s left) kms_pm_dc (dc5-retention-flops)
[105.269964] Starting subtest: dc5-retention-flops
[105.274701] Subtest dc5-retention-flops: SKIP (0.000s)
[105.339522] [021/133] (914s left) dmabuf (all-tests)
[105.376643] Starting subtest: all-tests
[105.379068] Starting dynamic subtest: sanitycheck
[105.518467] Dynamic subtest sanitycheck: SUCCESS (0.141s)
[105.529821] Starting dynamic subtest: dma_fence
[105.714544] Dynamic subtest dma_fence: SUCCESS (0.195s)
[105.725642] Starting dynamic subtest: dma_fence_chain
[115.113263] Dynamic subtest dma_fence_chain: SUCCESS (9.397s)
[115.123511] Starting dynamic subtest: dma_fence_unwrap
[115.211207] Dynamic subtest dma_fence_unwrap: SUCCESS (0.098s)
[115.221932] Starting dynamic subtest: dma_resv
[115.302066] Dynamic subtest dma_resv: SUCCESS (0.090s)
[115.304712] Subtest all-tests: SUCCESS (9.926s)
[115.386289] [022/133] (904s left) kms_draw_crc (fill-fb)
[115.481711] Starting subtest: fill-fb
[115.910740] Subtest fill-fb: SUCCESS (0.430s)
[116.009527] [023/133] (903s left) kms_cursor_edge_walk (64x64-left-edge)
[116.105070] Starting subtest: 64x64-left-edge
[116.107285] Starting dynamic subtest: pipe-A-eDP-1
[119.551034] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.446s)
[119.559853] Starting dynamic subtest: pipe-D-eDP-1
[122.678514] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.126s)
[122.680794] Subtest 64x64-left-edge: SUCCESS (6.574s)
[123.501344] [024/133] (895s left) perf_pmu (init-wait)
[123.549592] Starting subtest: init-wait
[123.551861] Starting dynamic subtest: rcs0
[123.554141] Dynamic subtest rcs0: SUCCESS (0.002s)
[123.562255] Starting dynamic subtest: bcs0
[123.564420] Dynamic subtest bcs0: SUCCESS (0.001s)
[123.571666] Starting dynamic subtest: vcs0
[123.573777] Dynamic subtest vcs0: SUCCESS (0.000s)
[123.580898] Starting dynamic subtest: vcs1
[123.583103] Dynamic subtest vcs1: SUCCESS (0.000s)
[123.590167] Starting dynamic subtest: vecs0
[123.592290] Dynamic subtest vecs0: SUCCESS (0.000s)
[123.599504] Starting dynamic subtest: ccs0
[123.601666] Dynamic subtest ccs0: SUCCESS (0.000s)
[123.603776] Subtest init-wait: SUCCESS (0.005s)
[123.672778] [025/133] (895s left) prime_busy (before)
[123.743160] Starting subtest: before
[123.745427] Starting dynamic subtest: rcs0
[123.778245] Dynamic subtest rcs0: SUCCESS (0.034s)
[123.787676] Starting dynamic subtest: bcs0
[123.826444] Dynamic subtest bcs0: SUCCESS (0.048s)
[123.835099] Starting dynamic subtest: vcs0
[123.865933] Dynamic subtest vcs0: SUCCESS (0.039s)
[123.873049] Starting dynamic subtest: vcs1
[123.907522] Dynamic subtest vcs1: SUCCESS (0.041s)
[123.917157] Starting dynamic subtest: vecs0
[123.948699] Dynamic subtest vecs0: SUCCESS (0.041s)
[123.957301] Starting dynamic subtest: ccs0
[123.989857] Dynamic subtest ccs0: SUCCESS (0.041s)
[124.098797] Subtest before: SUCCESS (0.356s)
[124.173089] [026/133] (895s left) perf (gen12-invalid-class-instance)
[124.317397] Starting subtest: gen12-invalid-class-instance
[124.325590] Subtest gen12-invalid-class-instance: SUCCESS (0.009s)
[124.371296] [027/133] (895s left) kms_flip_scaled_crc (flip-32bpp-linear-to-64bpp-linear-upscaling)
[124.467855] Starting subtest: flip-32bpp-linear-to-64bpp-linear-upscaling
[124.470343] Starting dynamic subtest: pipe-A-default-mode
[127.221774] Dynamic subtest pipe-A-default-mode: SUCCESS (2.754s)
[127.223951] Subtest flip-32bpp-linear-to-64bpp-linear-upscaling: SUCCESS (2.756s)
[128.080157] [028/133] (891s left) sw_sync (timeline_closed)
[128.116265] Starting subtest: timeline_closed
[128.118629] Subtest timeline_closed: SUCCESS (0.000s)
[128.165035] [029/133] (891s left) kms_joiner (basic-force-big-joiner)
[128.265778] Starting subtest: basic-force-big-joiner
[128.270430] Subtest basic-force-big-joiner: SKIP (0.000s)
[128.343060] [030/133] (891s left) kms_async_flips (crc-atomic)
[128.437123] Starting subtest: crc-atomic
[128.824032] Starting dynamic subtest: pipe-A-eDP-1
[131.715277] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.890s)
[132.102899] Starting dynamic subtest: pipe-B-eDP-1
[135.020659] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.926s)
[135.399175] Starting dynamic subtest: pipe-C-eDP-1
[138.244103] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.854s)
[138.626172] Starting dynamic subtest: pipe-D-eDP-1
[141.483113] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.865s)
[141.485374] Subtest crc-atomic: SUCCESS (13.048s)
[142.645553] [031/133] (877s left) gem_mmap_gtt (cpuset-medium-copy-odd)
[142.713563] Subtest cpuset-medium-copy-odd: SKIP (0.000s)
[142.775015] [032/133] (876s left) api_intel_bb (object-reloc-keep-cache)
[142.827685] Starting subtest: object-reloc-keep-cache
[142.831751] Subtest object-reloc-keep-cache: SKIP (0.003s)
[142.952878] [033/133] (876s left) gem_exec_capture (userptr)
[143.022798] Starting subtest: userptr
[143.862306] Subtest userptr: SUCCESS (0.840s)
[143.995171] [034/133] (875s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-pwrite)
[144.084760] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-pwrite
[144.088786] Subtest fbc-2p-primscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[144.195970] [035/133] (875s left) gem_exec_create (legacy)
[144.254684] Starting subtest: legacy
[144.257250] Starting dynamic subtest: smem
[147.927533] Dynamic subtest smem: SUCCESS (3.671s)
[147.930607] Subtest legacy: SUCCESS (3.672s)
[148.107192] [036/133] (871s left) kms_prime (basic-crc-hybrid)
[148.201740] Subtest basic-crc-hybrid: SKIP (0.000s)
[148.354549] [FACT kms_prime (basic-crc-hybrid)] new: kernel.kmod_is_loaded.vgem: true
[148.358167] [037/133] (871s left) kms_psr (fbc-psr-no-drrs)
[148.451335] Starting subtest: fbc-psr-no-drrs
[148.453235] Starting dynamic subtest: eDP-1
[148.457238] Dynamic subtest eDP-1: SKIP (0.000s)
[148.461270] Subtest fbc-psr-no-drrs: SKIP (0.001s)
[148.520176] [038/133] (871s left) gem_userptr_blits (stress-mm-invalidate-close)
[148.587729] Starting subtest: stress-mm-invalidate-close
[150.737922] Subtest stress-mm-invalidate-close: SUCCESS (2.148s)
[150.869107] [039/133] (869s left) kms_plane_multiple (2x-tiling-yf)
[150.961262] Starting subtest: 2x-tiling-yf
[150.965579] Subtest 2x-tiling-yf: SKIP (0.000s)
[151.037215] [040/133] (869s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-cpu)
[151.129116] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-cpu
[158.148053] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-cpu: SUCCESS (7.020s)
[158.259353] [041/133] (861s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-pwrite)
[158.354727] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-pwrite
[158.359234] Subtest fbc-2p-scndscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[158.444551] [042/133] (861s left) syncobj_timeline (etime-single-wait-all-submitted)
[158.498815] Starting subtest: etime-single-wait-all-submitted
[158.602402] Subtest etime-single-wait-all-submitted: SUCCESS (0.103s)
[158.708221] [043/133] (861s left) gem_exec_fence (syncobj-backward-timeline-chain-engines)
[159.231502] Starting subtest: syncobj-backward-timeline-chain-engines
[159.338928] Subtest syncobj-backward-timeline-chain-engines: SUCCESS (0.108s)
[161.024283] [044/133] (859s left) kms_cursor_crc (cursor-onscreen-64x64)
[161.209559] Starting subtest: cursor-onscreen-64x64
[161.211868] Starting dynamic subtest: pipe-A-eDP-1
[163.316813] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.103s)
[163.342433] Starting dynamic subtest: pipe-D-eDP-1
[166.059022] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.721s)
[166.061346] Subtest cursor-onscreen-64x64: SUCCESS (4.849s)
[166.942754] [045/133] (853s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-indfb-msflip-blt)
[167.034260] Starting subtest: fbc-2p-scndscrn-indfb-msflip-blt
[167.038195] Subtest fbc-2p-scndscrn-indfb-msflip-blt: SKIP (0.000s)
[167.133861] [046/133] (853s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-pwrite)
[167.226642] Starting subtest: psr-2p-primscrn-cur-indfb-draw-pwrite
[167.231075] Subtest psr-2p-primscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[167.327280] [047/133] (853s left) kms_flip_scaled_crc (flip-32bpp-ytileccs-to-64bpp-ytile-upscaling)
[167.420187] Starting subtest: flip-32bpp-ytileccs-to-64bpp-ytile-upscaling
[167.424701] Subtest flip-32bpp-ytileccs-to-64bpp-ytile-upscaling: SKIP (0.000s)
[167.490298] [048/133] (852s left) gem_workarounds (basic-read)
[167.545099] Starting subtest: basic-read
[167.557977] Subtest basic-read: SUCCESS (0.013s)
[167.654397] [049/133] (852s left) kms_chamelium_frames (dp-crc-fast)
[168.050755] Subtest dp-crc-fast: SKIP (0.000s)
[168.858505] [050/133] (851s left) kms_psr (fbc-pr-dpms)
[168.975825] Starting subtest: fbc-pr-dpms
[168.980071] Subtest fbc-pr-dpms: SKIP (0.000s)
[169.050087] [051/133] (851s left) kms_busy (extended-modeset-hang-newfb)
[169.152284] Starting subtest: extended-modeset-hang-newfb
[169.154239] Starting dynamic subtest: pipe-A
[203.805754] Dynamic subtest pipe-A: SUCCESS (34.653s)
[203.815802] Starting dynamic subtest: pipe-D
[226.783107] Dynamic subtest pipe-D: SUCCESS (22.976s)
[226.785478] Subtest extended-modeset-hang-newfb: SUCCESS (57.633s)
[227.581905] [052/133] (792s left) kms_psr2_sf (pr-plane-move-sf-dmg-area)
[227.687441] Starting subtest: pr-plane-move-sf-dmg-area
[227.691773] Subtest pr-plane-move-sf-dmg-area: SKIP (0.000s)
[227.768974] [053/133] (792s left) gem_ctx_persistence (heartbeat-close)
[227.829567] Starting subtest: heartbeat-close
[227.833550] Subtest heartbeat-close: SKIP (0.000s)
[227.926759] [054/133] (792s left) gem_eio (context-create)
[228.126583] Starting subtest: context-create
[228.398074] Subtest context-create: SUCCESS (0.271s)
[228.546027] [055/133] (792s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-blt)
[228.640248] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-blt
[228.643826] Subtest psr-2p-scndscrn-pri-indfb-draw-blt: SKIP (0.000s)
[228.744272] [056/133] (791s left) gem_exec_reloc (basic-active)
[228.811326] Subtest basic-active: SKIP (0.000s)
[228.885914] [057/133] (791s left) gem_userptr_blits (userfault)
[228.943941] Starting subtest: userfault
[228.948223] Subtest userfault: SUCCESS (0.008s)
[229.084490] [058/133] (791s left) kms_addfb_basic (tile-pitch-mismatch)
[229.149044] Starting subtest: tile-pitch-mismatch
[229.153182] Subtest tile-pitch-mismatch: SKIP (0.000s)
[229.287413] [059/133] (791s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-mmap-cpu)
[229.376428] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-mmap-cpu
[229.379995] Subtest fbc-2p-primscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[229.459503] [060/133] (791s left) kms_cursor_crc (cursor-random-64x21)
[229.664202] Starting subtest: cursor-random-64x21
[229.714922] Subtest cursor-random-64x21: SKIP (0.047s)
[229.964938] [061/133] (790s left) kms_cursor_legacy (2x-long-cursor-vs-flip-legacy)
[230.078954] Starting subtest: 2x-long-cursor-vs-flip-legacy
[230.082925] Subtest 2x-long-cursor-vs-flip-legacy: SKIP (0.001s)
[230.223206] [062/133] (790s left) sw_sync (sync_merge)
[230.262588] Starting subtest: sync_merge
[230.264374] Subtest sync_merge: SUCCESS (0.000s)
[230.307799] [063/133] (790s left) syncobj_timeline (reset-multiple-signaled)
[230.361142] Starting subtest: reset-multiple-signaled
[230.363012] Subtest reset-multiple-signaled: SUCCESS (0.000s)
[230.468784] [064/133] (790s left) syncobj_wait (invalid-single-wait-all-unsubmitted)
[230.520245] Starting subtest: invalid-single-wait-all-unsubmitted
[230.522021] Subtest invalid-single-wait-all-unsubmitted: SUCCESS (0.000s)
[230.634785] [065/133] (790s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-mmap-gtt)
[230.738609] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-mmap-gtt
[230.741914] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[230.828217] [066/133] (790s left) gem_exec_whisper (basic-contexts-priority)
[230.891586] Starting subtest: basic-contexts-priority
[254.600040] Subtest basic-contexts-priority: SUCCESS (23.703s)
[254.783108] [067/133] (766s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-mmap-gtt)
[254.891099] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-mmap-gtt
[254.895201] Subtest fbc-2p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[255.012804] [068/133] (766s left) kms_lease (possible-crtcs-filtering)
[255.099510] Starting subtest: possible-crtcs-filtering
[255.104422] Subtest possible-crtcs-filtering: SUCCESS (0.005s)
[255.209904] [069/133] (766s left) kms_cursor_legacy (basic-busy-flip-before-cursor-legacy)
[255.323140] Starting subtest: basic-busy-flip-before-cursor-legacy
[255.327507] Subtest basic-busy-flip-before-cursor-legacy: SKIP (0.000s)
[255.483479] [070/133] (765s left) kms_flip (absolute-wf_vblank)
[255.579414] Starting subtest: absolute-wf_vblank
[255.581705] Starting dynamic subtest: A-eDP1
[264.335067] Dynamic subtest A-eDP1: SUCCESS (8.758s)
[264.345618] Starting dynamic subtest: B-eDP1
[273.070073] Dynamic subtest B-eDP1: SUCCESS (8.733s)
[273.079381] Starting dynamic subtest: C-eDP1
[281.793563] Dynamic subtest C-eDP1: SUCCESS (8.723s)
[281.803698] Starting dynamic subtest: D-eDP1
[290.516263] Dynamic subtest D-eDP1: SUCCESS (8.722s)
[290.521811] Subtest absolute-wf_vblank: SUCCESS (34.945s)
[291.737269] [071/133] (729s left) kms_vblank (ts-continuation-modeset-rpm)
[291.823063] Starting subtest: ts-continuation-modeset-rpm
[291.825182] Starting dynamic subtest: pipe-A-eDP-1
[294.325441] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.504s)
[294.340218] Starting dynamic subtest: pipe-D-eDP-1
[296.572320] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.244s)
[296.574763] Subtest ts-continuation-modeset-rpm: SUCCESS (4.751s)
[297.373508] [072/133] (724s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-pwrite)
[297.472502] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-pwrite
[302.308775] Subtest fbc-1p-offscreen-pri-indfb-draw-pwrite: SUCCESS (4.840s)
[303.486637] [073/133] (717s left) gen9_exec_parse (basic-rejected-ctx-param)
[303.559378] Subtest basic-rejected-ctx-param: SKIP (0.000s)
[303.640093] [074/133] (717s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-0)
[303.734517] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-0
[304.857629] Subtest x-tiled-max-hw-stride-32bpp-rotate-0: SUCCESS (1.123s)
[304.980424] [075/133] (716s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-render)
[305.087850] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-render
[305.091204] Subtest psr-2p-scndscrn-spr-indfb-draw-render: SKIP (0.000s)
[305.196838] [076/133] (716s left) kms_frontbuffer_tracking (psr-2p-primscrn-shrfb-plflip-blt)
[305.295990] Starting subtest: psr-2p-primscrn-shrfb-plflip-blt
[305.299541] Subtest psr-2p-primscrn-shrfb-plflip-blt: SKIP (0.000s)
[305.394961] [077/133] (716s left) kms_ccs (bad-rotation-90-4-tiled-dg2-rc-ccs)
[305.484100] Starting subtest: bad-rotation-90-4-tiled-dg2-rc-ccs
[305.485879] Starting dynamic subtest: pipe-A-eDP-1
[305.504443] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[305.514481] Starting dynamic subtest: pipe-B-eDP-1
[305.532204] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[305.540791] Starting dynamic subtest: pipe-C-eDP-1
[305.558484] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[305.568222] Starting dynamic subtest: pipe-D-eDP-1
[305.586422] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[305.589817] Subtest bad-rotation-90-4-tiled-dg2-rc-ccs: SKIP (0.004s)
[307.735407] [078/133] (713s left) sysfs_heartbeat_interval (idempotent)
[307.792435] Starting subtest: idempotent
[307.794685] Starting dynamic subtest: vecs0
[307.796926] Dynamic subtest vecs0: SUCCESS (0.001s)
[307.807606] Starting dynamic subtest: ccs0
[307.809400] Dynamic subtest ccs0: SUCCESS (0.001s)
[307.817751] Starting dynamic subtest: vcs0
[307.819562] Dynamic subtest vcs0: SUCCESS (0.000s)
[307.828045] Starting dynamic subtest: bcs0
[307.829798] Dynamic subtest bcs0: SUCCESS (0.001s)
[307.838431] Starting dynamic subtest: rcs0
[307.840563] Dynamic subtest rcs0: SUCCESS (0.000s)
[307.849109] Starting dynamic subtest: vcs1
[307.850957] Dynamic subtest vcs1: SUCCESS (0.000s)
[307.852814] Subtest idempotent: SUCCESS (0.007s)
[307.896173] [079/133] (713s left) kms_rotation_crc (primary-yf-tiled-reflect-x-180)
[307.989892] Starting subtest: primary-yf-tiled-reflect-x-180
[308.049624] Subtest primary-yf-tiled-reflect-x-180: SKIP (0.059s)
[308.152101] [080/133] (713s left) gem_gpgpu_fill (offset-16x16)
[308.204470] Starting subtest: offset-16x16
[308.210181] Subtest offset-16x16: SUCCESS (0.008s)
[308.342787] [081/133] (713s left) kms_ccs (crc-primary-rotation-180-y-tiled-gen12-rc-ccs-cc)
[308.437319] Starting subtest: crc-primary-rotation-180-y-tiled-gen12-rc-ccs-cc
[308.439617] Starting dynamic subtest: pipe-A-eDP-1
[308.462275] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[308.472885] Starting dynamic subtest: pipe-B-eDP-1
[308.494202] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[308.502530] Starting dynamic subtest: pipe-C-eDP-1
[308.523495] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[308.531748] Starting dynamic subtest: pipe-D-eDP-1
[308.552626] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[308.556761] Subtest crc-primary-rotation-180-y-tiled-gen12-rc-ccs-cc: SKIP (0.005s)
[310.688566] [082/133] (711s left) perf_pmu (all-busy-check-all)
[310.735078] Starting subtest: all-busy-check-all
[311.893386] Subtest all-busy-check-all: SUCCESS (1.159s)
[312.010434] [083/133] (709s left) i915_query (query-topology-matches-eu-total)
[312.063565] Starting subtest: query-topology-matches-eu-total
[312.065469] Subtest query-topology-matches-eu-total: SUCCESS (0.000s)
[312.181143] [084/133] (709s left) kms_3d (basic)
[312.248673] Starting subtest: basic
[314.260701] Subtest basic: SUCCESS (2.015s)
[314.736746] [085/133] (707s left) kms_frontbuffer_tracking (fbcpsr-slowdraw)
[314.830687] Starting subtest: fbcpsr-slowdraw
[339.876937] Subtest fbcpsr-slowdraw: SUCCESS (25.050s)
[340.011856] [086/133] (681s left) syncobj_wait (wait-for-submit-snapshot)
[340.068034] Starting subtest: wait-for-submit-snapshot
[340.148370] Subtest wait-for-submit-snapshot: SUCCESS (0.081s)
[340.224787] [087/133] (681s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-mmap-wc)
[340.329621] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-mmap-wc
[340.333789] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[340.432508] [088/133] (681s left) gem_mmap_gtt (fault-concurrent-y)
[340.491043] Subtest fault-concurrent-Y: SKIP (0.000s)
[340.560808] [089/133] (681s left) kms_selftest (drm_cmdline_parser)
[340.598664] Starting subtest: drm_cmdline_parser
[340.657885] Starting dynamic subtest: drm_test_cmdline_force_d_only
[340.768354] Dynamic subtest drm_test_cmdline_force_d_only: SUCCESS (0.108s)
[340.778122] Starting dynamic subtest: drm_test_cmdline_force_D_only_dvi
[340.867284] Dynamic subtest drm_test_cmdline_force_D_only_dvi: SUCCESS (0.099s)
[340.877982] Starting dynamic subtest: drm_test_cmdline_force_D_only_hdmi
[340.952208] Dynamic subtest drm_test_cmdline_force_D_only_hdmi: SUCCESS (0.085s)
[340.962461] Starting dynamic subtest: drm_test_cmdline_force_D_only_not_digital
[341.057116] Dynamic subtest drm_test_cmdline_force_D_only_not_digital: SUCCESS (0.102s)
[341.067062] Starting dynamic subtest: drm_test_cmdline_force_e_only
[341.160066] Dynamic subtest drm_test_cmdline_force_e_only: SUCCESS (0.102s)
[341.170080] Starting dynamic subtest: drm_test_cmdline_res
[341.252202] Dynamic subtest drm_test_cmdline_res: SUCCESS (0.091s)
[341.262162] Starting dynamic subtest: drm_test_cmdline_res_vesa
[341.355282] Dynamic subtest drm_test_cmdline_res_vesa: SUCCESS (0.103s)
[341.366042] Starting dynamic subtest: drm_test_cmdline_res_vesa_rblank
[341.457565] Dynamic subtest drm_test_cmdline_res_vesa_rblank: SUCCESS (0.101s)
[341.467483] Starting dynamic subtest: drm_test_cmdline_res_rblank
[341.558086] Dynamic subtest drm_test_cmdline_res_rblank: SUCCESS (0.100s)
[341.568026] Starting dynamic subtest: drm_test_cmdline_res_bpp
[341.661143] Dynamic subtest drm_test_cmdline_res_bpp: SUCCESS (0.101s)
[341.671876] Starting dynamic subtest: drm_test_cmdline_res_refresh
[341.763038] Dynamic subtest drm_test_cmdline_res_refresh: SUCCESS (0.102s)
[341.773379] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh
[341.852558] Dynamic subtest drm_test_cmdline_res_bpp_refresh: SUCCESS (0.089s)
[341.860752] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_interlaced
[341.954491] Dynamic subtest drm_test_cmdline_res_bpp_refresh_interlaced: SUCCESS (0.102s)
[341.962904] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_margins
[342.043715] Dynamic subtest drm_test_cmdline_res_bpp_refresh_margins: SUCCESS (0.088s)
[342.052983] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_force_off
[342.139588] Dynamic subtest drm_test_cmdline_res_bpp_refresh_force_off: SUCCESS (0.095s)
[342.149140] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_force_on
[342.226662] Dynamic subtest drm_test_cmdline_res_bpp_refresh_force_on: SUCCESS (0.087s)
[342.236311] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_force_on_analog
[342.320272] Dynamic subtest drm_test_cmdline_res_bpp_refresh_force_on_analog: SUCCESS (0.092s)
[342.329903] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_force_on_digital
[342.410551] Dynamic subtest drm_test_cmdline_res_bpp_refresh_force_on_digital: SUCCESS (0.090s)
[342.420272] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_interlaced_margins_force_on
[342.492541] Dynamic subtest drm_test_cmdline_res_bpp_refresh_interlaced_margins_force_on: SUCCESS (0.081s)
[342.502098] Starting dynamic subtest: drm_test_cmdline_res_margins_force_on
[342.576667] Dynamic subtest drm_test_cmdline_res_margins_force_on: SUCCESS (0.083s)
[342.586344] Starting dynamic subtest: drm_test_cmdline_res_vesa_margins
[342.665352] Dynamic subtest drm_test_cmdline_res_vesa_margins: SUCCESS (0.089s)
[342.674861] Starting dynamic subtest: drm_test_cmdline_name
[342.754840] Dynamic subtest drm_test_cmdline_name: SUCCESS (0.088s)
[342.764707] Starting dynamic subtest: drm_test_cmdline_name_bpp
[342.848040] Dynamic subtest drm_test_cmdline_name_bpp: SUCCESS (0.094s)
[342.857426] Starting dynamic subtest: drm_test_cmdline_name_option
[342.939545] Dynamic subtest drm_test_cmdline_name_option: SUCCESS (0.090s)
[342.949647] Starting dynamic subtest: drm_test_cmdline_name_bpp_option
[343.030370] Dynamic subtest drm_test_cmdline_name_bpp_option: SUCCESS (0.090s)
[343.040514] Starting dynamic subtest: drm_test_cmdline_rotate_0
[343.113222] Dynamic subtest drm_test_cmdline_rotate_0: SUCCESS (0.083s)
[343.122738] Starting dynamic subtest: drm_test_cmdline_rotate_90
[343.195373] Dynamic subtest drm_test_cmdline_rotate_90: SUCCESS (0.080s)
[343.205049] Starting dynamic subtest: drm_test_cmdline_rotate_180
[343.277391] Dynamic subtest drm_test_cmdline_rotate_180: SUCCESS (0.082s)
[343.286627] Starting dynamic subtest: drm_test_cmdline_rotate_270
[343.358655] Dynamic subtest drm_test_cmdline_rotate_270: SUCCESS (0.080s)
[343.368724] Starting dynamic subtest: drm_test_cmdline_hmirror
[343.446502] Dynamic subtest drm_test_cmdline_hmirror: SUCCESS (0.088s)
[343.454746] Starting dynamic subtest: drm_test_cmdline_vmirror
[343.534394] Dynamic subtest drm_test_cmdline_vmirror: SUCCESS (0.087s)
[343.542943] Starting dynamic subtest: drm_test_cmdline_margin_options
[343.613382] Dynamic subtest drm_test_cmdline_margin_options: SUCCESS (0.079s)
[343.621749] Starting dynamic subtest: drm_test_cmdline_multiple_options
[343.710758] Dynamic subtest drm_test_cmdline_multiple_options: SUCCESS (0.096s)
[343.719169] Starting dynamic subtest: drm_test_cmdline_bpp_extra_and_option
[343.799344] Dynamic subtest drm_test_cmdline_bpp_extra_and_option: SUCCESS (0.087s)
[343.807774] Starting dynamic subtest: drm_test_cmdline_extra_and_option
[343.899260] Dynamic subtest drm_test_cmdline_extra_and_option: SUCCESS (0.099s)
[343.907714] Starting dynamic subtest: drm_test_cmdline_freestanding_options
[343.994893] Dynamic subtest drm_test_cmdline_freestanding_options: SUCCESS (0.095s)
[344.003256] Starting dynamic subtest: drm_test_cmdline_freestanding_force_e_and_options
[344.078308] Dynamic subtest drm_test_cmdline_freestanding_force_e_and_options: SUCCESS (0.082s)
[344.086414] Starting dynamic subtest: drm_test_cmdline_panel_orientation
[344.165611] Dynamic subtest drm_test_cmdline_panel_orientation: SUCCESS (0.087s)
[344.173655] Starting dynamic subtest: drm_test_cmdline_invalid
[344.261969] Dynamic subtest drm_test_cmdline_invalid: SUCCESS (0.095s)
[344.270062] Starting dynamic subtest: drm_test_cmdline_tv_options
[344.359018] Dynamic subtest drm_test_cmdline_tv_options: SUCCESS (0.097s)
[344.360851] Subtest drm_cmdline_parser: SUCCESS (3.761s)
[344.541955] [090/133] (677s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-render)
[344.646948] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-render
[348.383332] Subtest fbc-1p-primscrn-spr-indfb-draw-render: SUCCESS (3.738s)
[349.538614] [091/133] (672s left) kms_psr (fbc-psr2-cursor-mmap-gtt)
[349.639169] Starting subtest: fbc-psr2-cursor-mmap-gtt
[349.641478] Starting dynamic subtest: eDP-1
[349.645876] Dynamic subtest eDP-1: SKIP (0.000s)
[349.650406] Subtest fbc-psr2-cursor-mmap-gtt: SKIP (0.001s)
[349.710734] [092/133] (672s left) gem_exec_schedule (lateslice)
[349.797203] Starting subtest: lateslice
[349.799188] Starting dynamic subtest: rcs0
[349.807835] Dynamic subtest rcs0: SUCCESS (0.020s)
[349.819916] Starting dynamic subtest: bcs0
[349.825316] Dynamic subtest bcs0: SUCCESS (0.017s)
[349.834234] Starting dynamic subtest: vcs0
[349.844227] Dynamic subtest vcs0: SUCCESS (0.018s)
[349.852838] Starting dynamic subtest: vcs1
[349.862854] Dynamic subtest vcs1: SUCCESS (0.018s)
[349.871563] Starting dynamic subtest: vecs0
[349.880346] Dynamic subtest vecs0: SUCCESS (0.017s)
[349.889399] Starting dynamic subtest: ccs0
[349.898775] Dynamic subtest ccs0: SUCCESS (0.018s)
[349.901157] Subtest lateslice: SUCCESS (0.111s)
[351.002257] [093/133] (671s left) kms_atomic_transition (plane-all-transition-fencing)
[351.095268] Starting subtest: plane-all-transition-fencing
[351.097656] Starting dynamic subtest: pipe-A-eDP-1
[353.598197] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.505s)
[353.916708] Starting dynamic subtest: pipe-B-eDP-1
[357.115785] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.209s)
[357.423459] Subtest plane-all-transition-fencing: SUCCESS (6.329s)
[358.221444] [094/133] (664s left) kms_explicit_fence (multiplane-atomic-fence-wait)
[358.356901] Starting subtest: multiplane-atomic-fence-wait
[358.651041] Subtest multiplane-atomic-fence-wait: SUCCESS (0.294s)
[359.814482] [095/133] (662s left) gem_exec_reloc (basic-wc)
[359.866866] Subtest basic-wc: SKIP (0.000s)
[359.934430] [096/133] (662s left) kms_frontbuffer_tracking (fbc-modesetfrombusy)
[360.031957] Starting subtest: fbc-modesetfrombusy
[363.784755] Subtest fbc-modesetfrombusy: SUCCESS (3.757s)
[364.921624] [097/133] (657s left) kms_plane_scaling (plane-downscale-factor-0-5-with-rotation)
[365.023194] Starting subtest: plane-downscale-factor-0-5-with-rotation
[365.025574] Starting dynamic subtest: pipe-A
[365.041239] Dynamic subtest pipe-A: SKIP (0.016s)
[365.051079] Starting dynamic subtest: pipe-B
[365.072421] Dynamic subtest pipe-B: SKIP (0.030s)
[365.081315] Starting dynamic subtest: pipe-C
[365.100407] Dynamic subtest pipe-C: SKIP (0.028s)
[365.111322] Starting dynamic subtest: pipe-D
[365.129770] Dynamic subtest pipe-D: SKIP (0.029s)
[365.134120] Subtest plane-downscale-factor-0-5-with-rotation: SKIP (0.105s)
[365.286057] [098/133] (657s left) gem_fenced_exec_thrash (too-many-fences)
[365.353186] Subtest too-many-fences: SKIP (0.000s)
[365.426965] [099/133] (657s left) kms_frontbuffer_tracking (fbc-2p-primscrn-shrfb-msflip-blt)
[365.527052] Starting subtest: fbc-2p-primscrn-shrfb-msflip-blt
[365.531026] Subtest fbc-2p-primscrn-shrfb-msflip-blt: SKIP (0.000s)
[365.624848] [100/133] (656s left) kms_cursor_legacy (cursor-vs-flip-legacy)
[365.746112] Starting subtest: cursor-vs-flip-legacy
[395.427918] Subtest cursor-vs-flip-legacy: SUCCESS (29.680s)
[396.308033] [101/133] (626s left) kms_plane (pixel-format-4-tiled-mtl-rc-ccs-cc-modifier)
[396.399291] Starting subtest: pixel-format-4-tiled-mtl-rc-ccs-cc-modifier
[396.425554] Starting dynamic subtest: pipe-A-plane-0
[396.714036] Dynamic subtest pipe-A-plane-0: SUCCESS (0.289s)
[396.726139] Starting dynamic subtest: pipe-A-plane-3
[396.958501] Dynamic subtest pipe-A-plane-3: SUCCESS (0.242s)
[396.967509] Starting dynamic subtest: pipe-A-plane-5
[396.971632] Dynamic subtest pipe-A-plane-5: SKIP (0.000s)
[398.054688] Starting dynamic subtest: pipe-B-plane-0
[398.324694] Dynamic subtest pipe-B-plane-0: SUCCESS (0.277s)
[398.336025] Starting dynamic subtest: pipe-B-plane-3
[398.557609] Dynamic subtest pipe-B-plane-3: SUCCESS (0.233s)
[398.567797] Starting dynamic subtest: pipe-B-plane-5
[398.572059] Dynamic subtest pipe-B-plane-5: SKIP (0.000s)
[398.867367] Subtest pixel-format-4-tiled-mtl-rc-ccs-cc-modifier: SUCCESS (2.469s)
[399.698434] [102/133] (622s left) gem_close (basic)
[399.764529] Starting subtest: basic
[399.767052] Subtest basic: SUCCESS (0.000s)
[399.863952] [103/133] (622s left) kms_color_pipeline (plane-lut1d-ctm3x4-lut1d)
[399.966853] Starting subtest: plane-lut1d-ctm3x4-lut1d
[400.091731] Starting dynamic subtest: pipe-A-plane-0
[400.235822] Dynamic subtest pipe-A-plane-0: SUCCESS (0.144s)
[400.244973] Starting dynamic subtest: pipe-A-plane-1
[400.380464] Dynamic subtest pipe-A-plane-1: SUCCESS (0.144s)
[400.393942] Starting dynamic subtest: pipe-A-plane-2
[400.558618] Dynamic subtest pipe-A-plane-2: SUCCESS (0.177s)
[401.759786] Starting dynamic subtest: pipe-B-plane-0
[401.896303] Dynamic subtest pipe-B-plane-0: SUCCESS (0.144s)
[401.907982] Starting dynamic subtest: pipe-B-plane-1
[402.062638] Dynamic subtest pipe-B-plane-1: SUCCESS (0.166s)
[402.072109] Starting dynamic subtest: pipe-B-plane-2
[402.196138] Dynamic subtest pipe-B-plane-2: SUCCESS (0.132s)
[403.366575] Starting dynamic subtest: pipe-C-plane-0
[403.492513] Dynamic subtest pipe-C-plane-0: SUCCESS (0.133s)
[403.505195] Starting dynamic subtest: pipe-C-plane-1
[403.636282] Dynamic subtest pipe-C-plane-1: SUCCESS (0.142s)
[403.645711] Starting dynamic subtest: pipe-C-plane-2
[403.769698] Dynamic subtest pipe-C-plane-2: SUCCESS (0.133s)
[404.983771] Starting dynamic subtest: pipe-D-plane-0
[405.119615] Dynamic subtest pipe-D-plane-0: SUCCESS (0.143s)
[405.129314] Starting dynamic subtest: pipe-D-plane-1
[405.253062] Dynamic subtest pipe-D-plane-1: SUCCESS (0.133s)
[405.262380] Starting dynamic subtest: pipe-D-plane-2
[405.408736] Dynamic subtest pipe-D-plane-2: SUCCESS (0.155s)
[405.700651] Subtest plane-lut1d-ctm3x4-lut1d: SUCCESS (5.735s)
[406.501676] [104/133] (616s left) gem_render_copy (linear)
[406.560897] Starting subtest: linear
[406.563199] Starting dynamic subtest: smem
[406.600558] Dynamic subtest smem: SUCCESS (0.039s)
[406.603103] Subtest linear: SUCCESS (0.040s)
[406.820424] [105/133] (615s left) gem_pxp (verify-pxp-stale-buf-execution)
[406.948551] Starting subtest: verify-pxp-stale-buf-execution
[408.007896] Subtest verify-pxp-stale-buf-execution: SUCCESS (1.062s)
[408.140055] [106/133] (614s left) kms_cursor_legacy (forked-bo)
[408.259333] Starting subtest: forked-bo
[408.261504] Starting dynamic subtest: pipe-A
[413.713701] Dynamic subtest pipe-A: SUCCESS (5.450s)
[413.730148] Starting dynamic subtest: pipe-B
[419.193165] Dynamic subtest pipe-B: SUCCESS (5.477s)
[419.205323] Starting dynamic subtest: pipe-C
[424.678640] Dynamic subtest pipe-C: SUCCESS (5.481s)
[424.691169] Starting dynamic subtest: pipe-D
[430.140614] Dynamic subtest pipe-D: SUCCESS (5.462s)
[430.152280] Starting dynamic subtest: all-pipes
[435.642196] Dynamic subtest all-pipes: SUCCESS (5.499s)
[435.644653] Subtest forked-bo: SUCCESS (27.382s)
[435.786887] [107/133] (587s left) kms_flip (blocking-absolute-wf_vblank)
[435.898639] Starting subtest: blocking-absolute-wf_vblank
[435.900992] Starting dynamic subtest: A-eDP1
[444.630939] Dynamic subtest A-eDP1: SUCCESS (8.732s)
[444.650688] Starting dynamic subtest: B-eDP1
[453.324194] Dynamic subtest B-eDP1: SUCCESS (8.690s)
[453.333896] Starting dynamic subtest: C-eDP1
[462.023448] Dynamic subtest C-eDP1: SUCCESS (8.697s)
[462.035968] Starting dynamic subtest: D-eDP1
[470.708474] Dynamic subtest D-eDP1: SUCCESS (8.681s)
[470.713674] Subtest blocking-absolute-wf_vblank: SUCCESS (34.818s)
[471.905731] [108/133] (550s left) kms_big_fb (linear-64bpp-rotate-270)
[472.014303] Starting subtest: linear-64bpp-rotate-270
[472.032705] Subtest linear-64bpp-rotate-270: SKIP (0.018s)
[472.153028] [109/133] (550s left) kms_chamelium_hpd (vga-hpd-after-suspend)
[472.540159] Subtest vga-hpd-after-suspend: SKIP (0.000s)
[473.381944] [110/133] (549s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-0-hflip)
[473.493505] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-0-hflip
[473.497754] Subtest yf-tiled-max-hw-stride-64bpp-rotate-0-hflip: SKIP (0.000s)
[473.608695] [111/133] (549s left) gem_busy (extended)
[473.797332] Starting subtest: extended
[473.799839] Starting dynamic subtest: rcs0
[473.873896] Dynamic subtest rcs0: SUCCESS (0.076s)
[473.885181] Starting dynamic subtest: bcs0
[473.915825] Dynamic subtest bcs0: SUCCESS (0.040s)
[473.926342] Starting dynamic subtest: vcs0
[475.927432] Dynamic subtest vcs0: SUCCESS (2.007s)
[475.939224] Starting dynamic subtest: vcs1
[477.910103] Dynamic subtest vcs1: SUCCESS (1.981s)
[477.922210] Starting dynamic subtest: vecs0
[479.894187] Dynamic subtest vecs0: SUCCESS (1.981s)
[479.906540] Starting dynamic subtest: ccs0
[479.942210] Dynamic subtest ccs0: SUCCESS (0.046s)
[479.945103] Subtest extended: SUCCESS (6.146s)
[480.170481] [112/133] (542s left) gem_create (create-size-update)
[480.237527] Starting subtest: create-size-update
[480.239867] Subtest create-size-update: SUCCESS (0.000s)
[480.461718] [113/133] (542s left) kms_big_fb (x-tiled-64bpp-rotate-180)
[480.560066] Starting subtest: x-tiled-64bpp-rotate-180
[482.071695] Subtest x-tiled-64bpp-rotate-180: SUCCESS (1.512s)
[482.233345] [114/133] (540s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-cpu)
[482.327626] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-cpu
[482.331589] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[482.427400] [115/133] (540s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-indfb-draw-pwrite)
[482.521888] Starting subtest: psr-1p-offscreen-pri-indfb-draw-pwrite
[489.544682] Subtest psr-1p-offscreen-pri-indfb-draw-pwrite: SUCCESS (7.024s)
[489.669232] [116/133] (533s left) i915_pm_rps (engine-order)
[489.728733] Starting subtest: engine-order
[494.599084] Subtest engine-order: SUCCESS (4.870s)
[494.720713] [117/133] (528s left) syncobj_basic (illegal-fd-to-handle)
[494.772839] Starting subtest: illegal-fd-to-handle
[494.775156] Subtest illegal-fd-to-handle: SUCCESS (0.000s)
[494.886871] [118/133] (528s left) kms_prop_blob (invalid-set-prop-any)
[494.940096] Starting subtest: invalid-set-prop-any
[494.942378] Subtest invalid-set-prop-any: SUCCESS (0.000s)
[495.034339] [119/133] (528s left) gem_ctx_param (invalid-set-no-zeromap)
[495.086826] Starting subtest: invalid-set-no-zeromap
[495.089184] Subtest invalid-set-no-zeromap: SUCCESS (0.000s)
[495.179669] [120/133] (528s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-mmap-wc)
[495.285771] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-mmap-wc
[498.842577] Subtest fbc-1p-primscrn-spr-indfb-draw-mmap-wc: SUCCESS (3.561s)
[500.008889] [121/133] (523s left) gem_exec_balancer (invalid-bonds)
[500.065440] Starting subtest: invalid-bonds
[500.069704] Subtest invalid-bonds: SKIP (0.000s)
[500.366898] [122/133] (523s left) kms_psr (psr-cursor-mmap-cpu)
[500.460061] Starting subtest: psr-cursor-mmap-cpu
[500.462409] Starting dynamic subtest: eDP-1
[502.154185] Dynamic subtest eDP-1: SUCCESS (1.695s)
[502.156524] Subtest psr-cursor-mmap-cpu: SUCCESS (1.695s)
[502.993389] [123/133] (520s left) gem_render_copy (y-tiled-mc-ccs-to-vebox-y-tiled)
[503.055163] Starting subtest: y-tiled-mc-ccs-to-vebox-y-tiled
[503.059523] Subtest y-tiled-mc-ccs-to-vebox-y-tiled: SKIP (0.000s)
[503.240442] [124/133] (520s left) kms_cdclk (mode-transition)
[503.341324] Starting subtest: mode-transition
[503.343571] Starting dynamic subtest: pipe-A-eDP-1
[503.640088] Dynamic subtest pipe-A-eDP-1: SKIP (0.296s)
[503.650427] Starting dynamic subtest: pipe-B-eDP-1
[503.655073] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[503.664363] Starting dynamic subtest: pipe-C-eDP-1
[503.668909] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[503.678194] Starting dynamic subtest: pipe-D-eDP-1
[503.682630] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[503.686929] Subtest mode-transition: SKIP (0.303s)
[504.487832] [125/133] (519s left) kms_big_fb (y-tiled-64bpp-rotate-0)
[504.580065] Starting subtest: y-tiled-64bpp-rotate-0
[504.584459] Subtest y-tiled-64bpp-rotate-0: SKIP (0.000s)
[504.673774] [126/133] (518s left) kms_plane_scaling (planes-downscale-factor-0-5)
[504.761175] Starting subtest: planes-downscale-factor-0-5
[504.763393] Starting dynamic subtest: pipe-A
[504.781224] Dynamic subtest pipe-A: SKIP (0.016s)
[504.795621] Starting dynamic subtest: pipe-B
[504.815346] Dynamic subtest pipe-B: SKIP (0.035s)
[504.824983] Starting dynamic subtest: pipe-C
[504.848059] Dynamic subtest pipe-C: SKIP (0.031s)
[504.857245] Starting dynamic subtest: pipe-D
[504.881507] Dynamic subtest pipe-D: SKIP (0.033s)
[504.885233] Subtest planes-downscale-factor-0-5: SKIP (0.118s)
[504.980646] [127/133] (518s left) gem_pwrite (basic-exhaustion)
[505.052863] Subtest basic-exhaustion: SKIP (0.000s)
[505.115236] [128/133] (518s left) kms_plane_alpha_blend (constant-alpha-min)
[505.210063] Starting subtest: constant-alpha-min
[505.484032] Starting dynamic subtest: pipe-A-eDP-1
[506.172424] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.687s)
[506.182763] Starting dynamic subtest: pipe-D-eDP-1
[507.642960] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.470s)
[507.645469] Subtest constant-alpha-min: SUCCESS (2.436s)
[508.489544] [129/133] (515s left) gem_exec_schedule (semaphore-noskip)
[508.560829] Starting subtest: semaphore-noskip
[508.978276] Subtest semaphore-noskip: SUCCESS (0.427s)
[509.319062] [130/133] (514s left) kms_psr (pr-sprite-blt)
[509.413036] Starting subtest: pr-sprite-blt
[509.417151] Subtest pr-sprite-blt: SKIP (0.000s)
[509.496742] [131/133] (514s left) syncobj_wait (wait-all-for-submit-snapshot)
[509.559724] Starting subtest: wait-all-for-submit-snapshot
[509.638865] Subtest wait-all-for-submit-snapshot: SUCCESS (0.081s)
[509.714471] [132/133] (514s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-cpu)
[509.807554] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-cpu
[516.297383] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-cpu: SUCCESS (6.491s)
[516.424637] [133/133] (507s left) syncobj_wait (multi-wait-for-submit-signaled)
[516.471215] Starting subtest: multi-wait-for-submit-signaled
[516.473623] Subtest multi-wait-for-submit-signaled: SUCCESS (0.000s)
[516.562035] Closing watchdogs
results: parsing output: 0/ for test: gem_mmap_gtt
results: parsing output: 1/ for test: gem_softpin
results: parsing output: 2/ for test: kms_frontbuffer_tracking
results: parsing output: 3/ for test: syncobj_timeline
results: parsing output: 4/ for test: api_intel_allocator
results: parsing output: 5/ for test: kms_big_fb
results: parsing output: 6/ for test: kms_frontbuffer_tracking
results: parsing output: 7/ for test: kms_cursor_legacy
results: parsing output: 8/ for test: i915_pm_rps
results: parsing output: 9/ for test: kms_ccs
results: parsing output: 10/ for test: syncobj_eventfd
results: parsing output: 11/ for test: i915_drm_fdinfo
results: parsing output: 12/ for test: syncobj_wait
results: parsing output: 13/ for test: i915_module_load
results: parsing output: 14/ for test: syncobj_timeline
results: parsing output: 15/ for test: kms_ccs
results: parsing output: 16/ for test: gem_sync
results: parsing output: 17/ for test: kms_psr
results: parsing output: 18/ for test: kms_content_protection
results: parsing output: 19/ for test: kms_pm_dc
results: parsing output: 20/ for test: dmabuf
results: parsing output: 21/ for test: kms_draw_crc
results: parsing output: 22/ for test: kms_cursor_edge_walk
results: parsing output: 23/ for test: perf_pmu
results: parsing output: 24/ for test: prime_busy
results: parsing output: 25/ for test: perf
results: parsing output: 26/ for test: kms_flip_scaled_crc
results: parsing output: 27/ for test: sw_sync
results: parsing output: 28/ for test: kms_joiner
results: parsing output: 29/ for test: kms_async_flips
results: parsing output: 30/ for test: gem_mmap_gtt
results: parsing output: 31/ for test: api_intel_bb
results: parsing output: 32/ for test: gem_exec_capture
results: parsing output: 33/ for test: kms_frontbuffer_tracking
results: parsing output: 34/ for test: gem_exec_create
results: parsing output: 35/ for test: kms_prime
results: parsing output: 36/ for test: kms_psr
results: parsing output: 37/ for test: gem_userptr_blits
results: parsing output: 38/ for test: kms_plane_multiple
results: parsing output: 39/ for test: kms_frontbuffer_tracking
results: parsing output: 40/ for test: kms_frontbuffer_tracking
results: parsing output: 41/ for test: syncobj_timeline
results: parsing output: 42/ for test: gem_exec_fence
results: parsing output: 43/ for test: kms_cursor_crc
results: parsing output: 44/ for test: kms_frontbuffer_tracking
results: parsing output: 45/ for test: kms_frontbuffer_tracking
results: parsing output: 46/ for test: kms_flip_scaled_crc
results: parsing output: 47/ for test: gem_workarounds
results: parsing output: 48/ for test: kms_chamelium_frames
results: parsing output: 49/ for test: kms_psr
results: parsing output: 50/ for test: kms_busy
results: parsing output: 51/ for test: kms_psr2_sf
results: parsing output: 52/ for test: gem_ctx_persistence
results: parsing output: 53/ for test: gem_eio
results: parsing output: 54/ for test: kms_frontbuffer_tracking
results: parsing output: 55/ for test: gem_exec_reloc
results: parsing output: 56/ for test: gem_userptr_blits
results: parsing output: 57/ for test: kms_addfb_basic
results: parsing output: 58/ for test: kms_frontbuffer_tracking
results: parsing output: 59/ for test: kms_cursor_crc
results: parsing output: 60/ for test: kms_cursor_legacy
results: parsing output: 61/ for test: sw_sync
results: parsing output: 62/ for test: syncobj_timeline
results: parsing output: 63/ for test: syncobj_wait
results: parsing output: 64/ for test: kms_frontbuffer_tracking
results: parsing output: 65/ for test: gem_exec_whisper
results: parsing output: 66/ for test: kms_frontbuffer_tracking
results: parsing output: 67/ for test: kms_lease
results: parsing output: 68/ for test: kms_cursor_legacy
results: parsing output: 69/ for test: kms_flip
results: parsing output: 70/ for test: kms_vblank
results: parsing output: 71/ for test: kms_frontbuffer_tracking
results: parsing output: 72/ for test: gen9_exec_parse
results: parsing output: 73/ for test: kms_big_fb
results: parsing output: 74/ for test: kms_frontbuffer_tracking
results: parsing output: 75/ for test: kms_frontbuffer_tracking
results: parsing output: 76/ for test: kms_ccs
results: parsing output: 77/ for test: sysfs_heartbeat_interval
results: parsing output: 78/ for test: kms_rotation_crc
results: parsing output: 79/ for test: gem_gpgpu_fill
results: parsing output: 80/ for test: kms_ccs
results: parsing output: 81/ for test: perf_pmu
results: parsing output: 82/ for test: i915_query
results: parsing output: 83/ for test: kms_3d
results: parsing output: 84/ for test: kms_frontbuffer_tracking
results: parsing output: 85/ for test: syncobj_wait
results: parsing output: 86/ for test: kms_frontbuffer_tracking
results: parsing output: 87/ for test: gem_mmap_gtt
results: parsing output: 88/ for test: kms_selftest
results: parsing output: 89/ for test: kms_frontbuffer_tracking
results: parsing output: 90/ for test: kms_psr
results: parsing output: 91/ for test: gem_exec_schedule
results: parsing output: 92/ for test: kms_atomic_transition
results: parsing output: 93/ for test: kms_explicit_fence
results: parsing output: 94/ for test: gem_exec_reloc
results: parsing output: 95/ for test: kms_frontbuffer_tracking
results: parsing output: 96/ for test: kms_plane_scaling
results: parsing output: 97/ for test: gem_fenced_exec_thrash
results: parsing output: 98/ for test: kms_frontbuffer_tracking
results: parsing output: 99/ for test: kms_cursor_legacy
results: parsing output: 100/ for test: kms_plane
results: parsing output: 101/ for test: gem_close
results: parsing output: 102/ for test: kms_color_pipeline
results: parsing output: 103/ for test: gem_render_copy
results: parsing output: 104/ for test: gem_pxp
results: parsing output: 105/ for test: kms_cursor_legacy
results: parsing output: 106/ for test: kms_flip
results: parsing output: 107/ for test: kms_big_fb
results: parsing output: 108/ for test: kms_chamelium_hpd
results: parsing output: 109/ for test: kms_big_fb
results: parsing output: 110/ for test: gem_busy
results: parsing output: 111/ for test: gem_create
results: parsing output: 112/ for test: kms_big_fb
results: parsing output: 113/ for test: kms_frontbuffer_tracking
results: parsing output: 114/ for test: kms_frontbuffer_tracking
results: parsing output: 115/ for test: i915_pm_rps
results: parsing output: 116/ for test: syncobj_basic
results: parsing output: 117/ for test: kms_prop_blob
results: parsing output: 118/ for test: gem_ctx_param
results: parsing output: 119/ for test: kms_frontbuffer_tracking
results: parsing output: 120/ for test: gem_exec_balancer
results: parsing output: 121/ for test: kms_psr
results: parsing output: 122/ for test: gem_render_copy
results: parsing output: 123/ for test: kms_cdclk
results: parsing output: 124/ for test: kms_big_fb
results: parsing output: 125/ for test: kms_plane_scaling
results: parsing output: 126/ for test: gem_pwrite
results: parsing output: 127/ for test: kms_plane_alpha_blend
results: parsing output: 128/ for test: gem_exec_schedule
results: parsing output: 129/ for test: kms_psr
results: parsing output: 130/ for test: syncobj_wait
results: parsing output: 131/ for test: kms_frontbuffer_tracking
results: parsing output: 132/ for test: syncobj_wait
Done.