[58.762402] Initializing watchdogs
[58.762452]   /dev/watchdog0
[58.777733] [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.782457] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[58.785409] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[58.788980] [001/156] (960s left) kms_pm_dc (dc5-dpms)
[59.930090] Starting subtest: dc5-dpms
[61.988491] Subtest dc5-dpms: SUCCESS (2.028s)
[62.062770] [002/156] (957s left) i915_query (query-regions-unallocated)
[62.115778] Starting subtest: query-regions-unallocated
[62.118471] Subtest query-regions-unallocated: SUCCESS (0.000s)
[62.213837] [003/156] (957s left) kms_frontbuffer_tracking (psrhdr-shrfb-scaledprimary)
[62.323471] Starting subtest: psrhdr-shrfb-scaledprimary
[62.327754] Subtest psrhdr-shrfb-scaledprimary: SKIP (0.000s)
[62.436683] [004/156] (956s left) i915_fb_tiling (basic-x-tiling)
[62.492954] Subtest basic-x-tiling: SKIP (0.000s)
[62.547498] [005/156] (956s left) gem_exec_whisper (basic-contexts-forked)
[62.619190] Starting subtest: basic-contexts-forked
[87.659238] Subtest basic-contexts-forked: SUCCESS (24.954s)
[87.853211] [006/156] (931s left) kms_cursor_legacy (flip-vs-cursor-busy-crc-legacy)
[87.987938] Starting subtest: flip-vs-cursor-busy-crc-legacy
[88.757949] Subtest flip-vs-cursor-busy-crc-legacy: SUCCESS (0.768s)
[89.574171] [007/156] (929s left) syncobj_wait (invalid-wait-illegal-handle)
[89.634796] Starting subtest: invalid-wait-illegal-handle
[89.637135] Subtest invalid-wait-illegal-handle: SUCCESS (0.000s)
[89.732903] [008/156] (929s left) kms_flip (2x-modeset-vs-vblank-race-interruptible)
[89.825377] Starting subtest: 2x-modeset-vs-vblank-race-interruptible
[89.837268] Subtest 2x-modeset-vs-vblank-race-interruptible: SKIP (0.011s)
[89.912289] [009/156] (929s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-mmap-wc)
[90.014342] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-mmap-wc
[90.018568] Subtest fbc-2p-scndscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[90.130624] [010/156] (929s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-primscrn-spr-indfb-move)
[90.234015] Starting subtest: fbcpsrhdr-1p-primscrn-spr-indfb-move
[90.238727] Subtest fbcpsrhdr-1p-primscrn-spr-indfb-move: SKIP (0.000s)
[90.326928] [011/156] (929s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-mmap-wc)
[90.428478] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-mmap-wc
[90.432638] Subtest psr-2p-scndscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[90.517635] [012/156] (929s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-blt)
[90.623464] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-blt
[97.416873] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-blt: SUCCESS (6.795s)
[97.541640] [013/156] (922s left) kms_cursor_crc (cursor-offscreen-64x21)
[97.734764] Starting subtest: cursor-offscreen-64x21
[97.789821] Subtest cursor-offscreen-64x21: SKIP (0.050s)
[98.043746] [014/156] (921s left) kms_frontbuffer_tracking (fbchdr-2p-scndscrn-spr-indfb-draw-mmap-gtt)
[98.137387] Starting subtest: fbchdr-2p-scndscrn-spr-indfb-draw-mmap-gtt
[98.141513] Subtest fbchdr-2p-scndscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[98.244725] [015/156] (921s left) gem_userptr_blits (sd-probe)
[98.305831] Starting subtest: sd-probe
[98.307792] Subtest sd-probe: SUCCESS (0.001s)
[98.423674] [016/156] (921s left) kms_ccs (crc-primary-rotation-180-4-tiled-mtl-rc-ccs-cc)
[98.522176] Starting subtest: crc-primary-rotation-180-4-tiled-mtl-rc-ccs-cc
[98.524266] Starting dynamic subtest: pipe-A-eDP-1
[99.485369] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.956s)
[99.495116] Starting dynamic subtest: pipe-B-eDP-1
[101.142221] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.652s)
[101.152378] Starting dynamic subtest: pipe-C-eDP-1
[102.683799] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.540s)
[102.693804] Starting dynamic subtest: pipe-D-eDP-1
[104.205510] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.520s)
[104.207915] Subtest crc-primary-rotation-180-4-tiled-mtl-rc-ccs-cc: SUCCESS (5.671s)
[105.441678] [017/156] (914s left) kms_frontbuffer_tracking (psrhdr-1p-offscreen-pri-indfb-draw-mmap-wc)
[105.549053] Starting subtest: psrhdr-1p-offscreen-pri-indfb-draw-mmap-wc
[105.553290] Subtest psrhdr-1p-offscreen-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[105.638694] [018/156] (914s left) kms_content_protection (dp-mst-lic-type-0-hdcp14)
[105.775124] Starting subtest: dp-mst-lic-type-0-hdcp14
[105.779821] Subtest dp-mst-lic-type-0-hdcp14: SKIP (0.000s)
[105.900640] [019/156] (914s left) gem_shrink (reclaim)
[105.967590] Starting subtest: reclaim
[108.513542] Subtest reclaim: SUCCESS (2.536s)
[108.666982] [020/156] (911s left) gem_ctx_engines (independent)
[108.726911] Starting subtest: independent
[108.729311] Starting dynamic subtest: rcs0
[108.984680] Dynamic subtest rcs0: SUCCESS (0.256s)
[108.997140] Starting dynamic subtest: bcs0
[109.247775] Dynamic subtest bcs0: SUCCESS (0.262s)
[109.256774] Starting dynamic subtest: vcs0
[109.443724] Dynamic subtest vcs0: SUCCESS (0.195s)
[109.452254] Starting dynamic subtest: vcs1
[109.666340] Dynamic subtest vcs1: SUCCESS (0.223s)
[109.674387] Starting dynamic subtest: vecs0
[109.889779] Dynamic subtest vecs0: SUCCESS (0.223s)
[109.901584] Starting dynamic subtest: ccs0
[110.121195] Dynamic subtest ccs0: SUCCESS (0.231s)
[110.134249] Starting dynamic subtest: all-engines
[110.862916] Dynamic subtest all-engines: SUCCESS (0.741s)
[110.865582] Subtest independent: SUCCESS (2.134s)
[111.407295] [021/156] (908s left) kms_psr2_sf (pr-plane-move-sf-dmg-area)
[111.507665] Starting subtest: pr-plane-move-sf-dmg-area
[111.511710] Subtest pr-plane-move-sf-dmg-area: SKIP (0.000s)
[111.584073] [022/156] (908s left) kms_frontbuffer_tracking (hdr-1p-offscreen-pri-shrfb-draw-blt)
[111.683294] Starting subtest: hdr-1p-offscreen-pri-shrfb-draw-blt
[111.687913] Subtest hdr-1p-offscreen-pri-shrfb-draw-blt: SKIP (0.000s)
[111.763475] [023/156] (908s left) gem_mmap_gtt (cpuset-basic-small-copy)
[111.809534] Subtest cpuset-basic-small-copy: SKIP (0.000s)
[111.865828] [024/156] (908s left) i915_drm_fdinfo (busy-hang)
[111.900596] Starting subtest: busy-hang
[111.903386] Starting dynamic subtest: rcs0
[111.931387] Dynamic subtest rcs0: SKIP (0.030s)
[111.942184] Starting dynamic subtest: bcs0
[111.946204] Dynamic subtest bcs0: SKIP (0.001s)
[111.954693] Starting dynamic subtest: vcs0
[111.959363] Dynamic subtest vcs0: SKIP (0.001s)
[111.970385] Starting dynamic subtest: vcs1
[111.974573] Dynamic subtest vcs1: SKIP (0.000s)
[111.982972] Starting dynamic subtest: vecs0
[111.987171] Dynamic subtest vecs0: SKIP (0.001s)
[111.995180] Starting dynamic subtest: ccs0
[111.999205] Dynamic subtest ccs0: SKIP (0.000s)
[112.003237] Subtest busy-hang: SKIP (0.036s)
[112.037175] [025/156] (908s left) gem_mmap_gtt (big-copy-xy)
[112.088729] Subtest big-copy-XY: SKIP (0.000s)
[112.149081] [026/156] (908s left) kms_cursor_crc (cursor-rapid-movement-32x32)
[112.284949] Starting subtest: cursor-rapid-movement-32x32
[112.332369] Subtest cursor-rapid-movement-32x32: SKIP (0.044s)
[112.607577] [027/156] (907s left) kms_frontbuffer_tracking (hdr-2p-primscrn-indfb-pgflip-blt)
[112.707329] Starting subtest: hdr-2p-primscrn-indfb-pgflip-blt
[112.710957] Subtest hdr-2p-primscrn-indfb-pgflip-blt: SKIP (0.000s)
[112.786260] [028/156] (907s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-blt)
[112.884516] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-blt
[112.888415] Subtest fbc-2p-scndscrn-spr-indfb-draw-blt: SKIP (0.000s)
[112.983583] [029/156] (907s left) syncobj_timeline (reset-multiple-signaled)
[113.039338] Starting subtest: reset-multiple-signaled
[113.041442] Subtest reset-multiple-signaled: SUCCESS (0.001s)
[113.137673] [030/156] (907s left) kms_frontbuffer_tracking (psrhdr-2p-primscrn-spr-indfb-draw-render)
[113.230797] Starting subtest: psrhdr-2p-primscrn-spr-indfb-draw-render
[113.234227] Subtest psrhdr-2p-primscrn-spr-indfb-draw-render: SKIP (0.000s)
[113.330695] [031/156] (907s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-blt)
[113.429156] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-blt
[113.432788] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-blt: SKIP (0.000s)
[113.525132] [032/156] (907s left) kms_big_fb (x-tiled-64bpp-rotate-90)
[113.617488] Starting subtest: x-tiled-64bpp-rotate-90
[113.636926] Subtest x-tiled-64bpp-rotate-90: SKIP (0.019s)
[113.736364] [033/156] (906s left) kms_cursor_legacy (basic-busy-flip-before-cursor-atomic)
[113.862888] Starting subtest: basic-busy-flip-before-cursor-atomic
[113.866539] Subtest basic-busy-flip-before-cursor-atomic: SKIP (0.000s)
[114.000135] [034/156] (906s left) gem_ctx_sseu (mmap-args)
[114.048590] Subtest mmap-args: SKIP (0.000s)
[114.115866] [035/156] (906s left) kms_ccs (crc-primary-basic-4-tiled-mtl-mc-ccs)
[114.209312] Starting subtest: crc-primary-basic-4-tiled-mtl-mc-ccs
[114.211234] Starting dynamic subtest: pipe-A-eDP-1
[116.515980] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.306s)
[116.525149] Starting dynamic subtest: pipe-B-eDP-1
[119.025264] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.509s)
[119.033557] Starting dynamic subtest: pipe-C-eDP-1
[121.238985] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.212s)
[121.247880] Starting dynamic subtest: pipe-D-eDP-1
[123.559673] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.319s)
[123.561736] Subtest crc-primary-basic-4-tiled-mtl-mc-ccs: SUCCESS (9.350s)
[124.773730] [036/156] (895s left) kms_frontbuffer_tracking (psr-2p-primscrn-indfb-msflip-blt)
[124.874860] Starting subtest: psr-2p-primscrn-indfb-msflip-blt
[124.879265] Subtest psr-2p-primscrn-indfb-msflip-blt: SKIP (0.000s)
[124.974311] [037/156] (895s left) kms_frontbuffer_tracking (hdr-2p-scndscrn-pri-shrfb-draw-mmap-wc)
[125.066699] Starting subtest: hdr-2p-scndscrn-pri-shrfb-draw-mmap-wc
[125.071160] Subtest hdr-2p-scndscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[125.142295] [038/156] (895s left) kms_frontbuffer_tracking (fbchdr-2p-primscrn-cur-indfb-move)
[125.246496] Starting subtest: fbchdr-2p-primscrn-cur-indfb-move
[125.250585] Subtest fbchdr-2p-primscrn-cur-indfb-move: SKIP (0.000s)
[125.346314] [039/156] (895s left) gem_ctx_persistence (heartbeat-hang)
[125.396936] Starting subtest: heartbeat-hang
[125.401282] Subtest heartbeat-hang: SKIP (0.000s)
[125.512105] [040/156] (895s left) kms_big_fb (4-tiled-8bpp-rotate-0)
[125.608195] Starting subtest: 4-tiled-8bpp-rotate-0
[126.821583] Subtest 4-tiled-8bpp-rotate-0: SUCCESS (1.214s)
[126.930944] [041/156] (893s left) gem_exec_reloc (basic-cpu-noreloc)
[126.997226] Subtest basic-cpu-noreloc: SKIP (0.000s)
[127.069996] [042/156] (893s left) gem_exec_balancer (sliced)
[127.136670] Starting subtest: sliced
[127.140504] Subtest sliced: SKIP (0.000s)
[127.437378] [043/156] (893s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-render)
[127.537745] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-render
[131.787456] Subtest fbc-1p-offscreen-pri-indfb-draw-render: SUCCESS (4.254s)
[132.963548] [044/156] (888s left) gem_lmem_swapping (parallel-multi)
[133.005127] Subtest parallel-multi: SKIP (0.000s)
[133.049457] [045/156] (887s left) gem_ppgtt (blt-vs-render-ctx0)
[133.094402] Starting subtest: blt-vs-render-ctx0
[166.020408] Subtest blt-vs-render-ctx0: SUCCESS (32.922s)
[166.154374] [046/156] (854s left) kms_plane_scaling (plane-scaler-unity-scaling-with-rotation)
[166.289288] Starting subtest: plane-scaler-unity-scaling-with-rotation
[166.291489] Starting dynamic subtest: pipe-A
[166.528332] Dynamic subtest pipe-A: SUCCESS (0.241s)
[166.537621] Starting dynamic subtest: pipe-B
[167.837455] Dynamic subtest pipe-B: SUCCESS (1.308s)
[167.848679] Starting dynamic subtest: pipe-C
[169.168846] Dynamic subtest pipe-C: SUCCESS (1.331s)
[169.178748] Starting dynamic subtest: pipe-D
[170.503562] Dynamic subtest pipe-D: SUCCESS (1.334s)
[170.506458] Subtest plane-scaler-unity-scaling-with-rotation: SUCCESS (4.218s)
[171.687359] [047/156] (849s left) syncobj_wait (single-wait-for-submit-unsubmitted)
[171.746239] Starting subtest: single-wait-for-submit-unsubmitted
[171.853319] Subtest single-wait-for-submit-unsubmitted: SUCCESS (0.106s)
[171.940113] [048/156] (849s left) kms_frontbuffer_tracking (hdr-rgb565-draw-render)
[172.042195] Starting subtest: hdr-rgb565-draw-render
[172.046186] Subtest hdr-rgb565-draw-render: SKIP (0.000s)
[172.138366] [049/156] (849s left) kms_chamelium_hpd (hdmi-hpd-after-suspend)
[172.529989] Subtest hdmi-hpd-after-suspend: SKIP (0.000s)
[173.395603] [050/156] (847s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-offscreen-pri-shrfb-draw-mmap-wc)
[173.498604] Starting subtest: fbcpsrhdr-1p-offscreen-pri-shrfb-draw-mmap-wc
[173.502777] Subtest fbcpsrhdr-1p-offscreen-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[173.589087] [051/156] (847s left) gem_busy (parallel)
[173.765943] Starting subtest: parallel
[173.768318] Starting dynamic subtest: rcs0
[175.330353] Dynamic subtest rcs0: SUCCESS (1.562s)
[175.343235] Starting dynamic subtest: bcs0
[177.314332] Dynamic subtest bcs0: SUCCESS (1.981s)
[177.326659] Starting dynamic subtest: vcs0
[179.362803] Dynamic subtest vcs0: SUCCESS (2.045s)
[179.374540] Starting dynamic subtest: vcs1
[181.346351] Dynamic subtest vcs1: SUCCESS (1.981s)
[181.357868] Starting dynamic subtest: vecs0
[183.330432] Dynamic subtest vecs0: SUCCESS (1.982s)
[183.342824] Starting dynamic subtest: ccs0
[185.314089] Dynamic subtest ccs0: SUCCESS (1.981s)
[185.317116] Subtest parallel: SUCCESS (11.548s)
[185.552745] [052/156] (835s left) syncobj_eventfd (invalid-illegal-eventfd)
[185.604638] Starting subtest: invalid-illegal-eventfd
[185.606767] Subtest invalid-illegal-eventfd: SUCCESS (0.000s)
[185.697071] [053/156] (835s left) syncobj_wait (wait-any-interrupted)
[185.743672] Starting subtest: wait-any-interrupted
[185.845019] Subtest wait-any-interrupted: SUCCESS (0.102s)
[185.921154] [054/156] (835s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-blt)
[186.018960] Starting subtest: psr-1p-primscrn-cur-indfb-draw-blt
[192.830030] Subtest psr-1p-primscrn-cur-indfb-draw-blt: SUCCESS (6.816s)
[192.956868] [055/156] (828s left) kms_frontbuffer_tracking (fbchdr-2p-primscrn-spr-indfb-draw-mmap-gtt)
[193.057503] Starting subtest: fbchdr-2p-primscrn-spr-indfb-draw-mmap-gtt
[193.061441] Subtest fbchdr-2p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[193.158492] [056/156] (828s left) kms_color_pipeline (plane-lut1d-lut1d)
[193.272219] Starting subtest: plane-lut1d-lut1d
[193.428873] Starting dynamic subtest: pipe-A-plane-0
[193.606446] Dynamic subtest pipe-A-plane-0: SUCCESS (0.177s)
[193.618257] Starting dynamic subtest: pipe-A-plane-1
[193.772885] Dynamic subtest pipe-A-plane-1: SUCCESS (0.166s)
[193.781858] Starting dynamic subtest: pipe-A-plane-2
[193.939454] Dynamic subtest pipe-A-plane-2: SUCCESS (0.166s)
[195.160129] Starting dynamic subtest: pipe-B-plane-0
[195.318962] Dynamic subtest pipe-B-plane-0: SUCCESS (0.166s)
[195.328889] Starting dynamic subtest: pipe-B-plane-1
[195.508263] Dynamic subtest pipe-B-plane-1: SUCCESS (0.188s)
[195.517259] Starting dynamic subtest: pipe-B-plane-2
[195.697128] Dynamic subtest pipe-B-plane-2: SUCCESS (0.188s)
[196.879406] Starting dynamic subtest: pipe-C-plane-0
[197.027282] Dynamic subtest pipe-C-plane-0: SUCCESS (0.155s)
[197.037172] Starting dynamic subtest: pipe-C-plane-1
[197.183281] Dynamic subtest pipe-C-plane-1: SUCCESS (0.155s)
[197.192362] Starting dynamic subtest: pipe-C-plane-2
[197.338173] Dynamic subtest pipe-C-plane-2: SUCCESS (0.155s)
[198.539801] Starting dynamic subtest: pipe-D-plane-0
[198.699068] Dynamic subtest pipe-D-plane-0: SUCCESS (0.166s)
[198.708269] Starting dynamic subtest: pipe-D-plane-1
[198.855284] Dynamic subtest pipe-D-plane-1: SUCCESS (0.155s)
[198.864957] Starting dynamic subtest: pipe-D-plane-2
[199.021537] Dynamic subtest pipe-D-plane-2: SUCCESS (0.166s)
[199.308300] Subtest plane-lut1d-lut1d: SUCCESS (6.036s)
[200.179926] [057/156] (821s left) kms_flip (plain-flip-ts-check)
[200.269411] Starting subtest: plain-flip-ts-check
[200.271722] Starting dynamic subtest: A-eDP1
[209.172676] Dynamic subtest A-eDP1: SUCCESS (8.901s)
[209.186070] Starting dynamic subtest: B-eDP1
[218.005095] Dynamic subtest B-eDP1: SUCCESS (8.829s)
[218.014265] Starting dynamic subtest: C-eDP1
[226.833953] Dynamic subtest C-eDP1: SUCCESS (8.826s)
[226.844886] Starting dynamic subtest: D-eDP1
[235.681584] Dynamic subtest D-eDP1: SUCCESS (8.846s)
[235.686698] Subtest plain-flip-ts-check: SUCCESS (35.413s)
[236.871426] [058/156] (784s left) kms_chamelium_frames (hdmi-crc-single)
[237.252507] Subtest hdmi-crc-single: SKIP (0.000s)
[238.085905] [059/156] (783s left) kms_ccs (missing-ccs-buffer-4-tiled-mtl-rc-ccs)
[238.180338] Starting subtest: missing-ccs-buffer-4-tiled-mtl-rc-ccs
[238.182674] Starting dynamic subtest: pipe-A-eDP-1
[238.203678] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s)
[238.213940] Starting dynamic subtest: pipe-B-eDP-1
[238.233572] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[238.242126] Starting dynamic subtest: pipe-C-eDP-1
[238.261546] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[238.270066] Starting dynamic subtest: pipe-D-eDP-1
[238.289236] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[238.291140] Subtest missing-ccs-buffer-4-tiled-mtl-rc-ccs: SUCCESS (0.005s)
[240.464256] [060/156] (781s left) kms_big_fb (yf-tiled-8bpp-rotate-180)
[240.579544] Starting subtest: yf-tiled-8bpp-rotate-180
[240.583717] Subtest yf-tiled-8bpp-rotate-180: SKIP (0.000s)
[240.661992] [061/156] (780s left) kms_frontbuffer_tracking (hdr-2p-primscrn-spr-indfb-draw-pwrite)
[240.763921] Starting subtest: hdr-2p-primscrn-spr-indfb-draw-pwrite
[240.768033] Subtest hdr-2p-primscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[240.856950] [062/156] (780s left) kms_plane_multiple (tiling-4)
[240.955144] Starting subtest: tiling-4
[240.957514] Starting dynamic subtest: pipe-A-eDP-1
[244.721152] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.766s)
[244.730687] Starting dynamic subtest: pipe-B-eDP-1
[249.182728] Dynamic subtest pipe-B-eDP-1: SUCCESS (4.461s)
[249.192372] Starting dynamic subtest: pipe-C-eDP-1
[253.636285] Dynamic subtest pipe-C-eDP-1: SUCCESS (4.449s)
[253.645661] Starting dynamic subtest: pipe-D-eDP-1
[258.177728] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.542s)
[258.180176] Subtest tiling-4: SUCCESS (17.223s)
[258.986934] [063/156] (762s left) sysfs_timeslice_duration (invalid)
[259.053838] Starting subtest: invalid
[259.056211] Starting dynamic subtest: vecs0
[259.058470] Dynamic subtest vecs0: SUCCESS (0.000s)
[259.068020] Starting dynamic subtest: ccs0
[259.070231] Dynamic subtest ccs0: SUCCESS (0.000s)
[259.079058] Starting dynamic subtest: vcs0
[259.081215] Dynamic subtest vcs0: SUCCESS (0.000s)
[259.089969] Starting dynamic subtest: bcs0
[259.092288] Dynamic subtest bcs0: SUCCESS (0.000s)
[259.101076] Starting dynamic subtest: rcs0
[259.103257] Dynamic subtest rcs0: SUCCESS (0.000s)
[259.112028] Starting dynamic subtest: vcs1
[259.113905] Dynamic subtest vcs1: SUCCESS (0.000s)
[259.115859] Subtest invalid: SUCCESS (0.006s)
[259.169270] [064/156] (762s left) gem_ctx_param (set-priority-range)
[259.212905] Starting subtest: set-priority-range
[259.227082] Subtest set-priority-range: SUCCESS (0.014s)
[259.345673] [065/156] (762s left) api_intel_bb (add-remove-objects)
[259.409876] Starting subtest: add-remove-objects
[259.415212] Subtest add-remove-objects: SUCCESS (0.007s)
[259.506548] [066/156] (762s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip)
[259.611058] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip
[259.615300] Subtest y-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip: SKIP (0.000s)
[259.698497] [067/156] (762s left) kms_plane_scaling (planes-unity-scaling-downscale-factor-0-5)
[259.789169] Starting subtest: planes-unity-scaling-downscale-factor-0-5
[259.791457] Starting dynamic subtest: pipe-A
[259.814380] Dynamic subtest pipe-A: SKIP (0.022s)
[259.823893] Starting dynamic subtest: pipe-B
[259.849732] Dynamic subtest pipe-B: SKIP (0.033s)
[259.859026] Starting dynamic subtest: pipe-C
[259.881737] Dynamic subtest pipe-C: SKIP (0.033s)
[259.890674] Starting dynamic subtest: pipe-D
[259.914396] Dynamic subtest pipe-D: SKIP (0.033s)
[259.918048] Subtest planes-unity-scaling-downscale-factor-0-5: SKIP (0.124s)
[260.014555] [068/156] (761s left) gem_ctx_isolation (preservation-s3)
[260.070298] Starting subtest: preservation-S3
[260.072662] Starting dynamic subtest: rcs0
[275.991553] Dynamic subtest rcs0: SUCCESS (1.835s)
[276.001731] Starting dynamic subtest: bcs0
[292.965571] Dynamic subtest bcs0: SUCCESS (1.691s)
[292.977379] Starting dynamic subtest: vcs0
[309.994337] Dynamic subtest vcs0: SUCCESS (3.189s)
[310.004840] Starting dynamic subtest: vcs1
[327.975892] Dynamic subtest vcs1: SUCCESS (4.984s)
[327.986019] Starting dynamic subtest: vecs0
[345.964740] Dynamic subtest vecs0: SUCCESS (4.960s)
[345.976326] Starting dynamic subtest: ccs0
[363.970839] Dynamic subtest ccs0: SUCCESS (3.218s)
[363.973572] Subtest preservation-S3: SUCCESS (19.883s)
[375.207700] [069/156] (657s left) kms_cursor_crc (cursor-sliding-256x85)
[375.479709] Starting subtest: cursor-sliding-256x85
[375.536445] Subtest cursor-sliding-256x85: SKIP (0.049s)
[375.738035] [070/156] (657s left) kms_draw_crc (draw-method-blt)
[375.829053] Starting subtest: draw-method-blt
[375.831531] Starting dynamic subtest: xrgb8888-untiled
[376.098802] Dynamic subtest xrgb8888-untiled: SUCCESS (0.267s)
[376.109964] Starting dynamic subtest: rgb565-untiled
[376.340537] Dynamic subtest rgb565-untiled: SUCCESS (0.232s)
[376.351844] Starting dynamic subtest: xrgb2101010-untiled
[376.571730] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.222s)
[376.581729] Starting dynamic subtest: xbgr16161616f-untiled
[376.802423] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.221s)
[376.815618] Starting dynamic subtest: xrgb8888-xtiled
[376.941310] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.132s)
[376.951650] Starting dynamic subtest: rgb565-xtiled
[377.056305] Dynamic subtest rgb565-xtiled: SUCCESS (0.110s)
[377.066696] Starting dynamic subtest: xrgb2101010-xtiled
[377.171712] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.110s)
[377.182216] Starting dynamic subtest: xbgr16161616f-xtiled
[377.286186] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (0.110s)
[377.296313] Starting dynamic subtest: xrgb8888-4tiled
[377.412745] Dynamic subtest xrgb8888-4tiled: SUCCESS (0.121s)
[377.422822] Starting dynamic subtest: rgb565-4tiled
[377.539393] Dynamic subtest rgb565-4tiled: SUCCESS (0.122s)
[377.550323] Starting dynamic subtest: xrgb2101010-4tiled
[377.656878] Dynamic subtest xrgb2101010-4tiled: SUCCESS (0.110s)
[377.668315] Starting dynamic subtest: xbgr16161616f-4tiled
[377.780374] Dynamic subtest xbgr16161616f-4tiled: SUCCESS (0.121s)
[377.782656] Subtest draw-method-blt: SUCCESS (1.890s)
[377.888382] [071/156] (655s left) core_getclient (basic)
[377.945508] Starting subtest: basic
[377.947723] Subtest basic: SUCCESS (0.000s)
[378.047226] [072/156] (655s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-downscaling)
[378.143114] Starting subtest: flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-downscaling
[378.147737] Subtest flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-downscaling: SKIP (0.000s)
[378.230673] [073/156] (654s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-primscrn-pri-shrfb-draw-mmap-wc)
[378.325626] Starting subtest: fbcpsrhdr-2p-primscrn-pri-shrfb-draw-mmap-wc
[378.329505] Subtest fbcpsrhdr-2p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[378.430325] [074/156] (654s left) kms_frontbuffer_tracking (psrhdr-rgb101010-draw-mmap-wc)
[378.535802] Starting subtest: psrhdr-rgb101010-draw-mmap-wc
[378.540656] Subtest psrhdr-rgb101010-draw-mmap-wc: SKIP (0.000s)
[378.637676] [075/156] (654s left) syncobj_timeline (invalid-multi-wait-unsubmitted)
[378.684031] Starting subtest: invalid-multi-wait-unsubmitted
[378.686798] Subtest invalid-multi-wait-unsubmitted: SUCCESS (0.000s)
[378.773586] [076/156] (654s left) gem_pxp (reject-modify-context-protection-off-2)
[378.892118] Starting subtest: reject-modify-context-protection-off-2
[378.894428] Subtest reject-modify-context-protection-off-2: SUCCESS (0.002s)
[379.015309] [077/156] (654s left) prime_vgem (basic-fence-flip)
[379.168572] Starting subtest: basic-fence-flip
[379.521850] Subtest basic-fence-flip: SUCCESS (0.346s)
[379.631118] [FACT prime_vgem (basic-fence-flip)] new: kernel.kmod_is_loaded.vgem: true
[379.635169] [078/156] (653s left) gem_render_copy (y-tiled-mc-ccs-to-vebox-yf-tiled)
[379.699215] Starting subtest: y-tiled-mc-ccs-to-vebox-yf-tiled
[379.703874] Subtest y-tiled-mc-ccs-to-vebox-yf-tiled: SKIP (0.000s)
[379.885365] [079/156] (653s left) kms_joiner (invalid-modeset-ultra-joiner)
[379.984452] Starting subtest: invalid-modeset-ultra-joiner
[379.989672] Subtest invalid-modeset-ultra-joiner: SKIP (0.000s)
[380.049371] [080/156] (653s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-primscrn-pri-shrfb-draw-blt)
[380.148504] Starting subtest: fbcpsrhdr-1p-primscrn-pri-shrfb-draw-blt
[380.153466] Subtest fbcpsrhdr-1p-primscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[380.249629] [081/156] (653s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-180)
[380.342687] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-180
[381.422795] Subtest x-tiled-max-hw-stride-32bpp-rotate-180: SUCCESS (1.056s)
[381.545822] [082/156] (651s left) dumb_buffer (invalid-bpp)
[381.596708] Starting subtest: invalid-bpp
[381.599564] Subtest invalid-bpp: SUCCESS (0.000s)
[381.699239] [083/156] (651s left) kms_rotation_crc (multiplane-rotation-cropping-top)
[381.798765] Starting subtest: multiplane-rotation-cropping-top
[399.597148] Subtest multiplane-rotation-cropping-top: SUCCESS (17.660s)
[399.704420] [084/156] (633s left) gem_mmap_offset (clear)
[399.757515] Starting subtest: clear
[399.760520] Starting dynamic subtest: smem0
[424.579410] Dynamic subtest smem0: SUCCESS (24.799s)
[424.582100] Subtest clear: SUCCESS (24.801s)
[424.710068] [085/156] (608s left) kms_ccs (bad-aux-stride-y-tiled-gen12-mc-ccs)
[424.872755] Starting subtest: bad-aux-stride-y-tiled-gen12-mc-ccs
[424.875619] Starting dynamic subtest: pipe-A-eDP-1
[424.901560] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[424.913808] Starting dynamic subtest: pipe-B-eDP-1
[424.939323] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[424.949766] Starting dynamic subtest: pipe-C-eDP-1
[424.974474] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[424.984468] Starting dynamic subtest: pipe-D-eDP-1
[425.010310] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[425.014964] Subtest bad-aux-stride-y-tiled-gen12-mc-ccs: SKIP (0.005s)
[427.190198] [086/156] (606s left) kms_psr (psr2-cursor-render)
[427.287624] Starting subtest: psr2-cursor-render
[427.290118] Starting dynamic subtest: eDP-1
[428.982288] Dynamic subtest eDP-1: SUCCESS (1.693s)
[428.984852] Subtest psr2-cursor-render: SUCCESS (1.694s)
[429.868644] [087/156] (603s left) gen7_exec_parse (cmd-crossing-page)
[429.929507] Subtest cmd-crossing-page: SKIP (0.000s)
[429.991936] [088/156] (603s left) gem_exec_fence (syncobj-export)
[430.414046] Starting subtest: syncobj-export
[430.420700] Subtest syncobj-export: SUCCESS (0.005s)
[432.393746] [089/156] (601s left) kms_busy (extended-pageflip-hang-newfb)
[432.499472] Starting subtest: extended-pageflip-hang-newfb
[432.501510] Starting dynamic subtest: pipe-A
[459.113895] Dynamic subtest pipe-A: SUCCESS (26.600s)
[459.126885] Starting dynamic subtest: pipe-D
[484.128872] Dynamic subtest pipe-D: SUCCESS (25.014s)
[484.131794] Subtest extended-pageflip-hang-newfb: SUCCESS (51.619s)
[484.946284] [090/156] (548s left) syncobj_timeline (wait-for-submit-snapshot)
[485.011888] Starting subtest: wait-for-submit-snapshot
[485.095359] Subtest wait-for-submit-snapshot: SUCCESS (0.083s)
[485.178730] [091/156] (548s left) kms_frontbuffer_tracking (psrhdr-2p-scndscrn-indfb-msflip-blt)
[485.275132] Starting subtest: psrhdr-2p-scndscrn-indfb-msflip-blt
[485.279911] Subtest psrhdr-2p-scndscrn-indfb-msflip-blt: SKIP (0.000s)
[485.356605] [092/156] (548s left) kms_flip (basic-plain-flip)
[485.461271] Starting subtest: basic-plain-flip
[485.463760] Starting dynamic subtest: A-eDP1
[487.172846] Dynamic subtest A-eDP1: SUCCESS (1.714s)
[487.185550] Starting dynamic subtest: B-eDP1
[488.903842] Dynamic subtest B-eDP1: SUCCESS (1.728s)
[488.914904] Starting dynamic subtest: C-eDP1
[490.621652] Dynamic subtest C-eDP1: SUCCESS (1.717s)
[490.632445] Starting dynamic subtest: D-eDP1
[492.260028] Dynamic subtest D-eDP1: SUCCESS (1.637s)
[492.265684] Subtest basic-plain-flip: SUCCESS (6.809s)
[493.442086] [093/156] (540s left) gem_exec_schedule (preempt-other)
[493.520924] Starting subtest: preempt-other
[493.523740] Starting dynamic subtest: rcs0
[493.581569] Dynamic subtest rcs0: SUCCESS (0.073s)
[493.594957] Starting dynamic subtest: bcs0
[493.651982] Dynamic subtest bcs0: SUCCESS (0.070s)
[493.664774] Starting dynamic subtest: vcs0
[493.717399] Dynamic subtest vcs0: SUCCESS (0.064s)
[493.732511] Starting dynamic subtest: vcs1
[493.782073] Dynamic subtest vcs1: SUCCESS (0.064s)
[493.797105] Starting dynamic subtest: vecs0
[493.851553] Dynamic subtest vecs0: SUCCESS (0.069s)
[493.864775] Starting dynamic subtest: ccs0
[493.933874] Dynamic subtest ccs0: SUCCESS (0.081s)
[493.936866] Subtest preempt-other: SUCCESS (0.427s)
[495.394280] [094/156] (538s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-move)
[495.502697] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-move
[495.507329] Subtest fbcpsr-2p-primscrn-cur-indfb-move: SKIP (0.000s)
[495.593297] [095/156] (538s left) kms_flip (flip-vs-panning-interruptible)
[495.693425] Starting subtest: flip-vs-panning-interruptible
[495.696030] Starting dynamic subtest: A-eDP1
[504.450430] Dynamic subtest A-eDP1: SUCCESS (8.756s)
[504.460716] Starting dynamic subtest: B-eDP1
[513.198137] Dynamic subtest B-eDP1: SUCCESS (8.746s)
[513.212440] Starting dynamic subtest: C-eDP1
[521.914886] Dynamic subtest C-eDP1: SUCCESS (8.714s)
[521.925381] Starting dynamic subtest: D-eDP1
[530.649664] Dynamic subtest D-eDP1: SUCCESS (8.732s)
[530.652435] Subtest flip-vs-panning-interruptible: SUCCESS (34.957s)
[531.826068] [096/156] (502s left) gem_madvise (dontneed-before-exec)
[531.869664] Starting subtest: dontneed-before-exec
[531.887652] Subtest dontneed-before-exec: SKIP (0.013s)
[531.952167] [097/156] (502s left) gem_sync (basic-store-each)
[532.034273] Starting subtest: basic-store-each
[534.503881] Subtest basic-store-each: SUCCESS (2.483s)
[534.693361] [098/156] (499s left) kms_psr2_sf (psr2-primary-plane-update-sf-dmg-area-big-fb)
[534.791860] Starting subtest: psr2-primary-plane-update-sf-dmg-area-big-fb
[534.794365] Starting dynamic subtest: pipe-A-eDP-1
[541.531789] Dynamic subtest pipe-A-eDP-1: SUCCESS (6.743s)
[541.543805] Starting dynamic subtest: pipe-B-eDP-1
[548.722531] Dynamic subtest pipe-B-eDP-1: SUCCESS (7.186s)
[548.724809] Subtest psr2-primary-plane-update-sf-dmg-area-big-fb: SUCCESS (13.931s)
[549.588456] [099/156] (484s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-scndscrn-pri-shrfb-draw-blt)
[549.683455] Starting subtest: fbcpsrhdr-2p-scndscrn-pri-shrfb-draw-blt
[549.688580] Subtest fbcpsrhdr-2p-scndscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[549.793788] [100/156] (484s left) kms_frontbuffer_tracking (psrhdr-1p-offscreen-pri-shrfb-draw-render)
[549.885390] Starting subtest: psrhdr-1p-offscreen-pri-shrfb-draw-render
[549.890563] Subtest psrhdr-1p-offscreen-pri-shrfb-draw-render: SKIP (0.000s)
[549.984792] [101/156] (484s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-render)
[550.086154] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-render
[550.091544] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-render: SKIP (0.000s)
[550.198112] [102/156] (484s left) kms_psr (fbc-psr2-cursor-mmap-gtt)
[550.286845] Starting subtest: fbc-psr2-cursor-mmap-gtt
[550.289678] Starting dynamic subtest: eDP-1
[550.294862] Dynamic subtest eDP-1: SKIP (0.000s)
[550.300290] Subtest fbc-psr2-cursor-mmap-gtt: SKIP (0.001s)
[550.364362] [103/156] (484s left) gem_tiled_blits (basic)
[550.419706] Subtest basic: SKIP (0.000s)
[550.488279] [104/156] (484s left) gem_softpin (noreloc-interruptible)
[550.560752] Starting subtest: noreloc-interruptible
[555.954236] Subtest noreloc-interruptible: SUCCESS (5.390s)
[556.090943] [105/156] (478s left) gem_exec_flush (basic-wb-rw-default)
[556.151849] Starting subtest: basic-wb-rw-default
[561.618669] Subtest basic-wb-rw-default: SUCCESS (5.465s)
[561.818754] [106/156] (472s left) gem_set_tiling_vs_blt (tiled-to-tiled)
[561.875790] Subtest tiled-to-tiled: SKIP (0.000s)
[561.944853] [107/156] (472s left) kms_frontbuffer_tracking (fbcpsrhdr-rgb101010-draw-pwrite)
[562.043089] Starting subtest: fbcpsrhdr-rgb101010-draw-pwrite
[562.047723] Subtest fbcpsrhdr-rgb101010-draw-pwrite: SKIP (0.000s)
[562.140322] [108/156] (472s left) kms_frontbuffer_tracking (fbchdr-1p-primscrn-pri-indfb-draw-mmap-gtt)
[562.240262] Starting subtest: fbchdr-1p-primscrn-pri-indfb-draw-mmap-gtt
[562.245336] Subtest fbchdr-1p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[562.336076] [109/156] (472s left) gem_softpin (evict-snoop-interruptible)
[562.389278] Starting subtest: evict-snoop-interruptible
[562.394496] Subtest evict-snoop-interruptible: SKIP (0.000s)
[562.514867] [110/156] (472s left) kms_cdclk (plane-scaling)
[562.601533] Starting subtest: plane-scaling
[562.604061] Starting dynamic subtest: pipe-A-eDP-1
[562.888899] Dynamic subtest pipe-A-eDP-1: SKIP (0.286s)
[562.901338] Starting dynamic subtest: pipe-B-eDP-1
[562.906096] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[562.916128] Starting dynamic subtest: pipe-C-eDP-1
[562.920761] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[562.931855] Starting dynamic subtest: pipe-D-eDP-1
[562.937153] Dynamic subtest pipe-D-eDP-1: SKIP (0.002s)
[562.942132] Subtest plane-scaling: SKIP (0.295s)
[563.707250] [111/156] (471s left) kms_flip_scaled_crc (flip-32bpp-ytileccs-to-64bpp-ytile-downscaling)
[563.803634] Starting subtest: flip-32bpp-ytileccs-to-64bpp-ytile-downscaling
[563.808469] Subtest flip-32bpp-ytileccs-to-64bpp-ytile-downscaling: SKIP (0.000s)
[563.876543] [112/156] (470s left) kms_lease (simple-lease)
[563.967470] Starting subtest: simple-lease
[563.969864] Starting dynamic subtest: pipe-A-eDP-1
[564.475691] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.509s)
[564.487638] Starting dynamic subtest: pipe-B-eDP-1
[565.945457] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.465s)
[565.958922] Starting dynamic subtest: pipe-C-eDP-1
[567.340407] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.396s)
[567.351911] Starting dynamic subtest: pipe-D-eDP-1
[568.778255] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.436s)
[568.780863] Subtest simple-lease: SUCCESS (4.813s)
[569.667202] [113/156] (465s left) syncobj_timeline (invalid-signal-bad-pad)
[569.729131] Starting subtest: invalid-signal-bad-pad
[569.731848] Subtest invalid-signal-bad-pad: SUCCESS (0.000s)
[569.828355] [114/156] (465s left) kms_atomic (atomic-invalid-params)
[569.924620] Starting subtest: atomic-invalid-params
[569.927164] Starting dynamic subtest: pipe-A-eDP-1
[570.318660] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.392s)
[570.321344] Subtest atomic-invalid-params: SUCCESS (0.393s)
[571.201465] [115/156] (463s left) kms_plane_lowres (tiling-x)
[571.292641] Starting subtest: tiling-x
[571.295264] Starting dynamic subtest: pipe-A-eDP-1
[571.300149] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[571.593548] Starting dynamic subtest: pipe-B-eDP-1
[571.598285] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[571.608665] Starting dynamic subtest: pipe-C-eDP-1
[571.613720] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[571.623868] Starting dynamic subtest: pipe-D-eDP-1
[571.628718] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[571.633645] Subtest tiling-x: SKIP (0.300s)
[572.442382] [116/156] (462s left) kms_psr (psr-cursor-plane-move)
[572.525171] Starting subtest: psr-cursor-plane-move
[572.527481] Starting dynamic subtest: eDP-1
[574.236590] Dynamic subtest eDP-1: SUCCESS (1.713s)
[574.239461] Subtest psr-cursor-plane-move: SUCCESS (1.714s)
[575.124567] [117/156] (459s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-mmap-gtt)
[575.224650] Starting subtest: psr-2p-primscrn-pri-indfb-draw-mmap-gtt
[575.229693] Subtest psr-2p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[575.311498] [118/156] (459s left) kms_frontbuffer_tracking (fbc-shrfb-scaledprimary)
[575.405075] Starting subtest: fbc-shrfb-scaledprimary
[578.302638] Subtest fbc-shrfb-scaledprimary: SUCCESS (2.902s)
[579.508546] [119/156] (455s left) gem_eio (wait-1us)
[579.731300] Starting subtest: wait-1us
[580.114492] Subtest wait-1us: SUCCESS (0.384s)
[580.264165] [120/156] (454s left) kms_sequence (queue-idle)
[580.356594] Starting subtest: queue-idle
[580.359450] Starting dynamic subtest: pipe-A-eDP-1
[582.166535] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.811s)
[582.178881] Starting dynamic subtest: pipe-B-eDP-1
[584.678663] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.509s)
[584.689771] Starting dynamic subtest: pipe-C-eDP-1
[587.173724] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.495s)
[587.185534] Starting dynamic subtest: pipe-D-eDP-1
[589.607757] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.432s)
[589.610715] Subtest queue-idle: SUCCESS (9.251s)
[590.428419] [121/156] (444s left) kms_big_fb (linear-32bpp-rotate-90)
[590.536896] Starting subtest: linear-32bpp-rotate-90
[590.556265] Subtest linear-32bpp-rotate-90: SKIP (0.018s)
[590.663475] [122/156] (444s left) gem_fence_thrash (bo-write-verify-y)
[590.697593] Starting subtest: bo-write-verify-y
[590.722211] Subtest bo-write-verify-y: SKIP (0.020s)
[590.777878] [123/156] (444s left) kms_pm_rpm (system-suspend-modeset)
[592.509140] Starting subtest: system-suspend-modeset
[612.484100] Subtest system-suspend-modeset: SUCCESS (5.045s)
[616.901205] [124/156] (422s left) syncobj_wait (invalid-multi-wait-all-unsubmitted)
[616.965846] Starting subtest: invalid-multi-wait-all-unsubmitted
[616.968704] Subtest invalid-multi-wait-all-unsubmitted: SUCCESS (0.000s)
[617.071463] [125/156] (422s left) kms_psr2_sf (fbc-pr-cursor-plane-move-continuous-sf)
[617.168970] Starting subtest: fbc-pr-cursor-plane-move-continuous-sf
[617.173862] Subtest fbc-pr-cursor-plane-move-continuous-sf: SKIP (0.000s)
[617.240337] [126/156] (422s left) kms_frontbuffer_tracking (fbchdr-1p-offscreen-pri-shrfb-draw-render)
[617.344726] Starting subtest: fbchdr-1p-offscreen-pri-shrfb-draw-render
[617.349457] Subtest fbchdr-1p-offscreen-pri-shrfb-draw-render: SKIP (0.000s)
[617.456764] [127/156] (422s left) kms_cursor_legacy (basic-flip-after-cursor-atomic)
[617.573296] Starting subtest: basic-flip-after-cursor-atomic
[618.490610] Subtest basic-flip-after-cursor-atomic: SUCCESS (0.917s)
[619.307855] [128/156] (420s left) gem_fence_thrash (bo-copy)
[619.346515] Starting subtest: bo-copy
[619.358261] Subtest bo-copy: SKIP (0.014s)
[619.414735] [129/156] (420s left) syncobj_eventfd (binary-wait-signaled)
[619.460338] Starting subtest: binary-wait-signaled
[619.462972] Subtest binary-wait-signaled: SUCCESS (0.000s)
[619.547590] [130/156] (420s left) kms_plane (pixel-format-y-tiled-modifier-source-clamping)
[619.631521] Starting subtest: pixel-format-y-tiled-modifier-source-clamping
[619.636994] Subtest pixel-format-y-tiled-modifier-source-clamping: SKIP (0.000s)
[619.718515] [131/156] (420s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-onoff)
[619.813690] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-onoff
[619.818234] Subtest fbcpsr-2p-scndscrn-spr-indfb-onoff: SKIP (0.000s)
[619.898591] [132/156] (419s left) kms_frontbuffer_tracking (hdr-1p-primscrn-pri-shrfb-draw-pwrite)
[620.001517] Starting subtest: hdr-1p-primscrn-pri-shrfb-draw-pwrite
[620.006584] Subtest hdr-1p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[620.094757] [133/156] (419s left) gem_mmap_gtt (big-bo)
[620.143971] Subtest big-bo: SKIP (0.000s)
[620.205021] [134/156] (419s left) gem_userptr_blits (coherency-sync)
[620.272449] Starting subtest: coherency-sync
[620.474932] Subtest coherency-sync: SKIP (0.154s)
[620.572727] [135/156] (419s left) vgem_basic (sysfs)
[620.670547] Starting subtest: sysfs
[620.673537] Subtest sysfs: SUCCESS (0.000s)
[620.730789] [136/156] (419s left) syncobj_wait (invalid-multi-wait-all-unsubmitted-signaled)
[620.794714] Starting subtest: invalid-multi-wait-all-unsubmitted-signaled
[620.797706] Subtest invalid-multi-wait-all-unsubmitted-signaled: SUCCESS (0.000s)
[620.900139] [137/156] (419s left) kms_frontbuffer_tracking (fbchdr-rgb565-draw-blt)
[621.010454] Starting subtest: fbchdr-rgb565-draw-blt
[621.015568] Subtest fbchdr-rgb565-draw-blt: SKIP (0.000s)
[621.102512] [138/156] (418s left) i915_pm_rpm (reg-read-ioctl)
[622.671731] Starting subtest: reg-read-ioctl
[624.960724] Subtest reg-read-ioctl: SUCCESS (2.292s)
[625.352903] [139/156] (414s left) kms_rotation_crc (primary-y-tiled-reflect-x-270)
[625.446458] Starting subtest: primary-y-tiled-reflect-x-270
[625.451297] Subtest primary-y-tiled-reflect-x-270: SKIP (0.001s)
[625.523155] [140/156] (414s left) gem_exec_balancer (invalid-bonds)
[625.588793] Starting subtest: invalid-bonds
[625.594507] Subtest invalid-bonds: SKIP (0.000s)
[625.893049] [141/156] (414s left) gem_ctx_param (invalid-size-set)
[625.941918] Starting subtest: invalid-size-set
[625.944530] Subtest invalid-size-set: SUCCESS (0.001s)
[626.027940] [142/156] (414s left) syncobj_wait (multi-wait-all-signaled)
[626.088637] Starting subtest: multi-wait-all-signaled
[626.091699] Subtest multi-wait-all-signaled: SUCCESS (0.000s)
[626.177874] [143/156] (414s left) gem_ppgtt (shrink-vs-evict-pinned)
[626.235823] Starting subtest: shrink-vs-evict-pinned
[634.270897] Subtest shrink-vs-evict-pinned: SUCCESS (7.840s)
[634.361240] [144/156] (405s left) perf_pmu (init-busy)
[634.405577] Starting subtest: init-busy
[634.407980] Starting dynamic subtest: rcs0
[634.411187] Dynamic subtest rcs0: SUCCESS (0.001s)
[634.421977] Starting dynamic subtest: bcs0
[634.424323] Dynamic subtest bcs0: SUCCESS (0.001s)
[634.434845] Starting dynamic subtest: vcs0
[634.437474] Dynamic subtest vcs0: SUCCESS (0.001s)
[634.447950] Starting dynamic subtest: vcs1
[634.450552] Dynamic subtest vcs1: SUCCESS (0.000s)
[634.460873] Starting dynamic subtest: vecs0
[634.462920] Dynamic subtest vecs0: SUCCESS (0.001s)
[634.473082] Starting dynamic subtest: ccs0
[634.475403] Dynamic subtest ccs0: SUCCESS (0.002s)
[634.477558] Subtest init-busy: SUCCESS (0.009s)
[634.523681] [145/156] (405s left) kms_psr (fbc-psr-basic)
[634.615320] Starting subtest: fbc-psr-basic
[634.617946] Starting dynamic subtest: eDP-1
[634.622942] Dynamic subtest eDP-1: SKIP (0.000s)
[634.627640] Subtest fbc-psr-basic: SKIP (0.001s)
[634.714463] [146/156] (405s left) kms_addfb_basic (master-rmfb)
[634.770714] Starting subtest: master-rmfb
[634.773412] Subtest master-rmfb: SUCCESS (0.002s)
[634.908387] [147/156] (405s left) kms_frontbuffer_tracking (psrhdr-1p-primscrn-spr-indfb-draw-mmap-cpu)
[635.005467] Starting subtest: psrhdr-1p-primscrn-spr-indfb-draw-mmap-cpu
[635.010682] Subtest psrhdr-1p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[635.112558] [148/156] (405s left) gem_exec_reloc (basic-write-wc-active)
[635.165256] Subtest basic-write-wc-active: SKIP (0.000s)
[635.241263] [149/156] (405s left) gem_exec_schedule (timeslicing)
[635.309083] Starting subtest: timeslicing
[635.311219] Starting dynamic subtest: rcs0
[635.319345] Dynamic subtest rcs0: SUCCESS (0.021s)
[635.330999] Starting dynamic subtest: bcs0
[635.342722] Dynamic subtest bcs0: SUCCESS (0.022s)
[635.353308] Starting dynamic subtest: vcs0
[635.364700] Dynamic subtest vcs0: SUCCESS (0.021s)
[635.375199] Starting dynamic subtest: vcs1
[635.386303] Dynamic subtest vcs1: SUCCESS (0.021s)
[635.397406] Starting dynamic subtest: vecs0
[635.408415] Dynamic subtest vecs0: SUCCESS (0.021s)
[635.422398] Starting dynamic subtest: ccs0
[635.428714] Dynamic subtest ccs0: SUCCESS (0.019s)
[635.431545] Subtest timeslicing: SUCCESS (0.129s)
[637.345228] [150/156] (403s left) kms_vblank (wait-busy-hang)
[637.451608] Starting subtest: wait-busy-hang
[637.454524] Starting dynamic subtest: pipe-A-eDP-1
[664.039570] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.500s)
[664.058706] Starting dynamic subtest: pipe-D-eDP-1
[679.080983] Dynamic subtest pipe-D-eDP-1: SUCCESS (15.036s)
[679.083601] Subtest wait-busy-hang: SUCCESS (41.541s)
[679.915625] [151/156] (360s left) kms_addfb_basic (bad-pitch-256)
[679.977721] Starting subtest: bad-pitch-256
[679.980089] Subtest bad-pitch-256: SUCCESS (0.000s)
[680.105861] [152/156] (360s left) gem_spin_batch (spin-all-new)
[680.169433] Starting subtest: spin-all-new
[680.182420] Subtest spin-all-new: SUCCESS (0.016s)
[681.295104] [153/156] (359s left) kms_frontbuffer_tracking (psr-2p-scndscrn-shrfb-pgflip-blt)
[681.400207] Starting subtest: psr-2p-scndscrn-shrfb-pgflip-blt
[681.404648] Subtest psr-2p-scndscrn-shrfb-pgflip-blt: SKIP (0.000s)
[681.494441] [154/156] (359s left) gem_exec_schedule (fairslice)
[681.554475] Starting subtest: fairslice
[681.556458] Starting dynamic subtest: rcs0
[683.573587] Dynamic subtest rcs0: SUCCESS (2.022s)
[683.585430] Starting dynamic subtest: bcs0
[685.600278] Dynamic subtest bcs0: SUCCESS (2.020s)
[685.611508] Starting dynamic subtest: vcs0
[687.620928] Dynamic subtest vcs0: SUCCESS (2.020s)
[687.632324] Starting dynamic subtest: vcs1
[689.638536] Dynamic subtest vcs1: SUCCESS (2.018s)
[689.652993] Starting dynamic subtest: vecs0
[691.662671] Dynamic subtest vecs0: SUCCESS (2.019s)
[691.675959] Starting dynamic subtest: ccs0
[693.682510] Dynamic subtest ccs0: SUCCESS (2.019s)
[693.685001] Subtest fairslice: SUCCESS (12.126s)
[693.984313] [155/156] (346s left) perf (gen12-group-exclusive-stream-sample-oa)
[694.121746] Starting subtest: gen12-group-exclusive-stream-sample-oa
[694.143504] Subtest gen12-group-exclusive-stream-sample-oa: SUCCESS (0.023s)
[694.184940] [156/156] (346s left) kms_dp_link_training (uhbr-sst)
[694.286423] Starting subtest: uhbr-sst
[694.297392] Subtest uhbr-sst: SKIP (0.000s)
[694.357822] Closing watchdogs
results: parsing output: 0/ for test: kms_pm_dc
results: parsing output: 1/ for test: i915_query
results: parsing output: 2/ for test: kms_frontbuffer_tracking
results: parsing output: 3/ for test: i915_fb_tiling
results: parsing output: 4/ for test: gem_exec_whisper
results: parsing output: 5/ for test: kms_cursor_legacy
results: parsing output: 6/ for test: syncobj_wait
results: parsing output: 7/ for test: kms_flip
results: parsing output: 8/ for test: kms_frontbuffer_tracking
results: parsing output: 9/ for test: kms_frontbuffer_tracking
results: parsing output: 10/ for test: kms_frontbuffer_tracking
results: parsing output: 11/ for test: kms_frontbuffer_tracking
results: parsing output: 12/ for test: kms_cursor_crc
results: parsing output: 13/ for test: kms_frontbuffer_tracking
results: parsing output: 14/ for test: gem_userptr_blits
results: parsing output: 15/ for test: kms_ccs
results: parsing output: 16/ for test: kms_frontbuffer_tracking
results: parsing output: 17/ for test: kms_content_protection
results: parsing output: 18/ for test: gem_shrink
results: parsing output: 19/ for test: gem_ctx_engines
results: parsing output: 20/ for test: kms_psr2_sf
results: parsing output: 21/ for test: kms_frontbuffer_tracking
results: parsing output: 22/ for test: gem_mmap_gtt
results: parsing output: 23/ for test: i915_drm_fdinfo
results: parsing output: 24/ for test: gem_mmap_gtt
results: parsing output: 25/ for test: kms_cursor_crc
results: parsing output: 26/ for test: kms_frontbuffer_tracking
results: parsing output: 27/ for test: kms_frontbuffer_tracking
results: parsing output: 28/ for test: syncobj_timeline
results: parsing output: 29/ for test: kms_frontbuffer_tracking
results: parsing output: 30/ for test: kms_frontbuffer_tracking
results: parsing output: 31/ for test: kms_big_fb
results: parsing output: 32/ for test: kms_cursor_legacy
results: parsing output: 33/ for test: gem_ctx_sseu
results: parsing output: 34/ for test: kms_ccs
results: parsing output: 35/ for test: kms_frontbuffer_tracking
results: parsing output: 36/ for test: kms_frontbuffer_tracking
results: parsing output: 37/ for test: kms_frontbuffer_tracking
results: parsing output: 38/ for test: gem_ctx_persistence
results: parsing output: 39/ for test: kms_big_fb
results: parsing output: 40/ for test: gem_exec_reloc
results: parsing output: 41/ for test: gem_exec_balancer
results: parsing output: 42/ for test: kms_frontbuffer_tracking
results: parsing output: 43/ for test: gem_lmem_swapping
results: parsing output: 44/ for test: gem_ppgtt
results: parsing output: 45/ for test: kms_plane_scaling
results: parsing output: 46/ for test: syncobj_wait
results: parsing output: 47/ for test: kms_frontbuffer_tracking
results: parsing output: 48/ for test: kms_chamelium_hpd
results: parsing output: 49/ for test: kms_frontbuffer_tracking
results: parsing output: 50/ for test: gem_busy
results: parsing output: 51/ for test: syncobj_eventfd
results: parsing output: 52/ for test: syncobj_wait
results: parsing output: 53/ for test: kms_frontbuffer_tracking
results: parsing output: 54/ for test: kms_frontbuffer_tracking
results: parsing output: 55/ for test: kms_color_pipeline
results: parsing output: 56/ for test: kms_flip
results: parsing output: 57/ for test: kms_chamelium_frames
results: parsing output: 58/ for test: kms_ccs
results: parsing output: 59/ for test: kms_big_fb
results: parsing output: 60/ for test: kms_frontbuffer_tracking
results: parsing output: 61/ for test: kms_plane_multiple
results: parsing output: 62/ for test: sysfs_timeslice_duration
results: parsing output: 63/ for test: gem_ctx_param
results: parsing output: 64/ for test: api_intel_bb
results: parsing output: 65/ for test: kms_big_fb
results: parsing output: 66/ for test: kms_plane_scaling
results: parsing output: 67/ for test: gem_ctx_isolation
results: parsing output: 68/ for test: kms_cursor_crc
results: parsing output: 69/ for test: kms_draw_crc
results: parsing output: 70/ for test: core_getclient
results: parsing output: 71/ for test: kms_flip_scaled_crc
results: parsing output: 72/ for test: kms_frontbuffer_tracking
results: parsing output: 73/ for test: kms_frontbuffer_tracking
results: parsing output: 74/ for test: syncobj_timeline
results: parsing output: 75/ for test: gem_pxp
results: parsing output: 76/ for test: prime_vgem
results: parsing output: 77/ for test: gem_render_copy
results: parsing output: 78/ for test: kms_joiner
results: parsing output: 79/ for test: kms_frontbuffer_tracking
results: parsing output: 80/ for test: kms_big_fb
results: parsing output: 81/ for test: dumb_buffer
results: parsing output: 82/ for test: kms_rotation_crc
results: parsing output: 83/ for test: gem_mmap_offset
results: parsing output: 84/ for test: kms_ccs
results: parsing output: 85/ for test: kms_psr
results: parsing output: 86/ for test: gen7_exec_parse
results: parsing output: 87/ for test: gem_exec_fence
results: parsing output: 88/ for test: kms_busy
results: parsing output: 89/ for test: syncobj_timeline
results: parsing output: 90/ for test: kms_frontbuffer_tracking
results: parsing output: 91/ for test: kms_flip
results: parsing output: 92/ for test: gem_exec_schedule
results: parsing output: 93/ for test: kms_frontbuffer_tracking
results: parsing output: 94/ for test: kms_flip
results: parsing output: 95/ for test: gem_madvise
results: parsing output: 96/ for test: gem_sync
results: parsing output: 97/ for test: kms_psr2_sf
results: parsing output: 98/ for test: kms_frontbuffer_tracking
results: parsing output: 99/ for test: kms_frontbuffer_tracking
results: parsing output: 100/ for test: kms_frontbuffer_tracking
results: parsing output: 101/ for test: kms_psr
results: parsing output: 102/ for test: gem_tiled_blits
results: parsing output: 103/ for test: gem_softpin
results: parsing output: 104/ for test: gem_exec_flush
results: parsing output: 105/ for test: gem_set_tiling_vs_blt
results: parsing output: 106/ for test: kms_frontbuffer_tracking
results: parsing output: 107/ for test: kms_frontbuffer_tracking
results: parsing output: 108/ for test: gem_softpin
results: parsing output: 109/ for test: kms_cdclk
results: parsing output: 110/ for test: kms_flip_scaled_crc
results: parsing output: 111/ for test: kms_lease
results: parsing output: 112/ for test: syncobj_timeline
results: parsing output: 113/ for test: kms_atomic
results: parsing output: 114/ for test: kms_plane_lowres
results: parsing output: 115/ for test: kms_psr
results: parsing output: 116/ for test: kms_frontbuffer_tracking
results: parsing output: 117/ for test: kms_frontbuffer_tracking
results: parsing output: 118/ for test: gem_eio
results: parsing output: 119/ for test: kms_sequence
results: parsing output: 120/ for test: kms_big_fb
results: parsing output: 121/ for test: gem_fence_thrash
results: parsing output: 122/ for test: kms_pm_rpm
results: parsing output: 123/ for test: syncobj_wait
results: parsing output: 124/ for test: kms_psr2_sf
results: parsing output: 125/ for test: kms_frontbuffer_tracking
results: parsing output: 126/ for test: kms_cursor_legacy
results: parsing output: 127/ for test: gem_fence_thrash
results: parsing output: 128/ for test: syncobj_eventfd
results: parsing output: 129/ for test: kms_plane
results: parsing output: 130/ for test: kms_frontbuffer_tracking
results: parsing output: 131/ for test: kms_frontbuffer_tracking
results: parsing output: 132/ for test: gem_mmap_gtt
results: parsing output: 133/ for test: gem_userptr_blits
results: parsing output: 134/ for test: vgem_basic
results: parsing output: 135/ for test: syncobj_wait
results: parsing output: 136/ for test: kms_frontbuffer_tracking
results: parsing output: 137/ for test: i915_pm_rpm
results: parsing output: 138/ for test: kms_rotation_crc
results: parsing output: 139/ for test: gem_exec_balancer
results: parsing output: 140/ for test: gem_ctx_param
results: parsing output: 141/ for test: syncobj_wait
results: parsing output: 142/ for test: gem_ppgtt
results: parsing output: 143/ for test: perf_pmu
results: parsing output: 144/ for test: kms_psr
results: parsing output: 145/ for test: kms_addfb_basic
results: parsing output: 146/ for test: kms_frontbuffer_tracking
results: parsing output: 147/ for test: gem_exec_reloc
results: parsing output: 148/ for test: gem_exec_schedule
results: parsing output: 149/ for test: kms_vblank
results: parsing output: 150/ for test: kms_addfb_basic
results: parsing output: 151/ for test: gem_spin_batch
results: parsing output: 152/ for test: kms_frontbuffer_tracking
results: parsing output: 153/ for test: gem_exec_schedule
results: parsing output: 154/ for test: perf
results: parsing output: 155/ for test: kms_dp_link_training
Done.