[59.701617] Initializing watchdogs
[59.701743]   /dev/watchdog0
[59.722007] [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]
[59.726546] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[59.729114] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[59.732486] [001/133] (960s left) kms_frontbuffer_tracking (psr-shrfb-scaledprimary)
[59.869260] Starting subtest: psr-shrfb-scaledprimary
[65.661874] Subtest psr-shrfb-scaledprimary: SUCCESS (5.796s)
[65.789684] [002/133] (954s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-indfb-draw-render)
[65.902300] Starting subtest: psr-1p-offscreen-pri-indfb-draw-render
[72.827929] Subtest psr-1p-offscreen-pri-indfb-draw-render: SUCCESS (6.928s)
[72.961734] [003/133] (947s left) gem_fenced_exec_thrash (too-many-fences)
[73.022812] Subtest too-many-fences: SKIP (0.000s)
[73.087515] [004/133] (947s left) kms_rotation_crc (primary-rotation-180)
[73.191055] Starting subtest: primary-rotation-180
[80.131342] Subtest primary-rotation-180: SUCCESS (6.942s)
[81.305970] [005/133] (939s left) kms_psr (fbc-psr-primary-blt)
[81.404860] Starting subtest: fbc-psr-primary-blt
[81.407173] Starting dynamic subtest: eDP-1
[81.411730] Dynamic subtest eDP-1: SKIP (0.000s)
[81.416411] Subtest fbc-psr-primary-blt: SKIP (0.000s)
[81.474101] [006/133] (938s left) kms_frontbuffer_tracking (psr-rgb101010-draw-mmap-cpu)
[81.568456] Starting subtest: psr-rgb101010-draw-mmap-cpu
[88.585107] Subtest psr-rgb101010-draw-mmap-cpu: SUCCESS (7.019s)
[88.684217] [007/133] (931s left) kms_cursor_legacy (basic-busy-flip-before-cursor-varying-size)
[88.804342] Starting subtest: basic-busy-flip-before-cursor-varying-size
[88.808986] Subtest basic-busy-flip-before-cursor-varying-size: SKIP (0.000s)
[88.949968] [008/133] (931s left) kms_psr2_sf (psr2-primary-plane-update-sf-dmg-area)
[89.040918] Starting subtest: psr2-primary-plane-update-sf-dmg-area
[89.043213] Starting dynamic subtest: pipe-A-eDP-1
[94.920368] Dynamic subtest pipe-A-eDP-1: SUCCESS (5.882s)
[94.929357] Starting dynamic subtest: pipe-B-eDP-1
[101.590354] Dynamic subtest pipe-B-eDP-1: SUCCESS (6.669s)
[101.592653] Subtest psr2-primary-plane-update-sf-dmg-area: SUCCESS (12.553s)
[102.461505] [009/133] (918s left) gem_eio (reset-stress)
[102.686868] Starting subtest: reset-stress
[102.689082] Starting dynamic subtest: render
[107.658653] Dynamic subtest render: SUCCESS (4.968s)
[107.672554] Starting dynamic subtest: bsd1
[125.396946] Dynamic subtest bsd1: SUCCESS (17.736s)
[125.411704] Starting dynamic subtest: bsd2
[143.449859] Dynamic subtest bsd2: SUCCESS (18.053s)
[143.462130] Starting dynamic subtest: blt
[143.466187] Dynamic subtest blt: SKIP (0.000s)
[143.473877] Starting dynamic subtest: vebox
[161.436060] Dynamic subtest vebox: SUCCESS (17.984s)
[161.438334] Subtest reset-stress: SUCCESS (58.745s)
[162.935692] [FACT gem_eio (reset-stress)] new: kernel.kmod_is_loaded.vgem: true
[162.939033] [010/133] (857s left) perf (oa-formats)
[163.071649] Starting subtest: oa-formats
[163.073876] Starting dynamic subtest: 0-rcs0
[163.083339] Dynamic subtest 0-rcs0: SUCCESS (0.013s)
[163.092125] Starting dynamic subtest: 1-vcs1
[163.105425] Dynamic subtest 1-vcs1: SUCCESS (0.022s)
[163.107686] Subtest oa-formats: SUCCESS (0.036s)
[163.154802] [011/133] (857s left) syncobj_timeline (etime-single-wait-all-for-submit-submitted)
[163.216077] Starting subtest: etime-single-wait-all-for-submit-submitted
[163.324580] Subtest etime-single-wait-all-for-submit-submitted: SUCCESS (0.107s)
[163.396220] [012/133] (857s left) kms_universal_plane (universal-plane-sanity)
[163.479191] Starting subtest: universal-plane-sanity
[163.481610] Starting dynamic subtest: pipe-A-eDP-1
[164.100098] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.620s)
[164.111601] Starting dynamic subtest: pipe-B-eDP-1
[165.286435] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.183s)
[165.295688] Starting dynamic subtest: pipe-C-eDP-1
[166.503092] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.215s)
[166.511870] Starting dynamic subtest: pipe-D-eDP-1
[167.770611] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.267s)
[167.772951] Subtest universal-plane-sanity: SUCCESS (4.290s)
[168.599763] [013/133] (852s left) gem_mmap_offset (open-flood)
[168.669060] Starting subtest: open-flood
[190.157363] Subtest open-flood: SUCCESS (21.490s)
[190.267859] [014/133] (830s left) kms_vblank (ts-continuation-modeset)
[190.369984] Starting subtest: ts-continuation-modeset
[190.371879] Starting dynamic subtest: pipe-A-eDP-1
[191.877803] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.505s)
[191.891316] Starting dynamic subtest: pipe-D-eDP-1
[194.054612] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.172s)
[194.056908] Subtest ts-continuation-modeset: SUCCESS (3.682s)
[194.856181] [015/133] (825s left) kms_flip (flip-vs-dpms-off-vs-modeset-interruptible)
[194.950898] Starting subtest: flip-vs-dpms-off-vs-modeset-interruptible
[194.953232] Starting dynamic subtest: A-eDP1
[198.583719] Dynamic subtest A-eDP1: SUCCESS (3.630s)
[198.593114] Starting dynamic subtest: B-eDP1
[201.764214] Dynamic subtest B-eDP1: SUCCESS (3.180s)
[201.773551] Starting dynamic subtest: C-eDP1
[204.870728] Dynamic subtest C-eDP1: SUCCESS (3.104s)
[204.878537] Starting dynamic subtest: D-eDP1
[207.989050] Dynamic subtest D-eDP1: SUCCESS (3.116s)
[207.990973] Subtest flip-vs-dpms-off-vs-modeset-interruptible: SUCCESS (13.039s)
[208.800455] [016/133] (812s left) kms_flip (2x-modeset-vs-vblank-race-interruptible)
[208.903786] Starting subtest: 2x-modeset-vs-vblank-race-interruptible
[208.915385] Subtest 2x-modeset-vs-vblank-race-interruptible: SKIP (0.010s)
[208.989964] [017/133] (811s left) api_intel_allocator (fork-simple-once)
[209.056464] Starting subtest: fork-simple-once
[209.065689] Subtest fork-simple-once: SUCCESS (0.013s)
[209.173651] [018/133] (811s left) perf_pmu (busy-accuracy-2)
[209.215060] Starting subtest: busy-accuracy-2
[209.217414] Starting dynamic subtest: rcs0
[212.254081] Dynamic subtest rcs0: SUCCESS (3.040s)
[212.261986] Starting dynamic subtest: bcs0
[215.312120] Dynamic subtest bcs0: SUCCESS (3.055s)
[215.321876] Starting dynamic subtest: vcs0
[218.356874] Dynamic subtest vcs0: SUCCESS (3.043s)
[218.365526] Starting dynamic subtest: vcs1
[221.407639] Dynamic subtest vcs1: SUCCESS (3.048s)
[221.417844] Starting dynamic subtest: vecs0
[224.454927] Dynamic subtest vecs0: SUCCESS (3.045s)
[224.465197] Starting dynamic subtest: ccs0
[227.516066] Dynamic subtest ccs0: SUCCESS (3.059s)
[227.518257] Subtest busy-accuracy-2: SUCCESS (18.304s)
[227.630355] [019/133] (793s left) kms_ccs (bad-aux-stride-y-tiled-gen12-rc-ccs)
[227.732143] Starting subtest: bad-aux-stride-y-tiled-gen12-rc-ccs
[227.734379] Starting dynamic subtest: pipe-A-eDP-1
[227.756664] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[227.765469] Starting dynamic subtest: pipe-B-eDP-1
[227.786961] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[227.794536] Starting dynamic subtest: pipe-C-eDP-1
[227.815731] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[227.823066] Starting dynamic subtest: pipe-D-eDP-1
[227.844766] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[227.849235] Subtest bad-aux-stride-y-tiled-gen12-rc-ccs: SKIP (0.005s)
[230.047783] [020/133] (790s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-mmap-cpu)
[230.158786] Starting subtest: psr-2p-primscrn-pri-indfb-draw-mmap-cpu
[230.163281] Subtest psr-2p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[230.274523] [021/133] (790s left) fbdev (unaligned-write)
[230.323439] Starting subtest: unaligned-write
[230.426417] Subtest unaligned-write: SUCCESS (0.101s)
[230.488691] [022/133] (790s left) kms_flip_scaled_crc (flip-64bpp-yftile-to-16bpp-yftile-upscaling)
[230.577138] Starting subtest: flip-64bpp-yftile-to-16bpp-yftile-upscaling
[230.581247] Subtest flip-64bpp-yftile-to-16bpp-yftile-upscaling: SKIP (0.000s)
[230.651081] [023/133] (790s left) gem_madvise (dontneed-before-mmap)
[230.688664] Starting subtest: dontneed-before-mmap
[230.706715] Subtest dontneed-before-mmap: SUCCESS (0.019s)
[230.826867] [024/133] (790s left) syncobj_wait (signal)
[230.896750] Starting subtest: signal
[230.899141] Subtest signal: SUCCESS (0.000s)
[231.010732] [025/133] (790s left) kms_ccs (missing-ccs-buffer-4-tiled-mtl-mc-ccs)
[231.103784] Starting subtest: missing-ccs-buffer-4-tiled-mtl-mc-ccs
[231.105605] Starting dynamic subtest: pipe-A-eDP-1
[231.126462] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.019s)
[231.137057] Starting dynamic subtest: pipe-B-eDP-1
[231.157506] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.019s)
[231.166744] Starting dynamic subtest: pipe-C-eDP-1
[231.187364] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.019s)
[231.197257] Starting dynamic subtest: pipe-D-eDP-1
[231.215690] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.019s)
[231.217664] Subtest missing-ccs-buffer-4-tiled-mtl-mc-ccs: SUCCESS (0.082s)
[233.415447] [026/133] (787s left) kms_flip (2x-single-buffer-flip-vs-dpms-off-vs-modeset-interruptible)
[233.509282] Starting subtest: 2x-single-buffer-flip-vs-dpms-off-vs-modeset-interruptible
[233.521083] Subtest 2x-single-buffer-flip-vs-dpms-off-vs-modeset-interruptible: SKIP (0.010s)
[233.594203] [027/133] (787s left) gem_gpgpu_fill (basic)
[233.655531] Starting subtest: basic
[233.657838] Starting dynamic subtest: smem
[233.663431] Dynamic subtest smem: SUCCESS (0.008s)
[233.665637] Subtest basic: SUCCESS (0.008s)
[233.825387] [028/133] (787s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-mmap-gtt)
[233.920263] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-mmap-gtt
[233.924587] Subtest fbc-2p-scndscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[234.025454] [029/133] (787s left) kms_addfb_basic (bad-pitch-0)
[234.072836] Starting subtest: bad-pitch-0
[234.074764] Subtest bad-pitch-0: SUCCESS (0.000s)
[234.194091] [030/133] (787s left) syncobj_timeline (invalid-signal-bad-pad)
[234.244640] Starting subtest: invalid-signal-bad-pad
[234.246823] Subtest invalid-signal-bad-pad: SUCCESS (0.000s)
[234.325668] [031/133] (787s left) kms_frontbuffer_tracking (fbc-2p-primscrn-indfb-pgflip-blt)
[234.428109] Starting subtest: fbc-2p-primscrn-indfb-pgflip-blt
[234.431351] Subtest fbc-2p-primscrn-indfb-pgflip-blt: SKIP (0.000s)
[234.518426] [032/133] (786s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-32bpp-ytilercccs-downscaling)
[234.614273] Starting subtest: flip-64bpp-ytile-to-32bpp-ytilercccs-downscaling
[234.617531] Subtest flip-64bpp-ytile-to-32bpp-ytilercccs-downscaling: SKIP (0.000s)
[234.700722] [033/133] (786s left) gem_exec_reloc (basic-gtt-cpu)
[234.755714] Subtest basic-gtt-cpu: SKIP (0.000s)
[234.814296] [034/133] (786s left) gem_tiled_blits (interruptible)
[234.870907] Subtest interruptible: SKIP (0.000s)
[234.941404] [035/133] (786s left) kms_getfb (getfb-repeated-different-handles)
[235.027267] Starting subtest: getfb-repeated-different-handles
[235.029109] Subtest getfb-repeated-different-handles: SUCCESS (0.000s)
[235.127172] [036/133] (786s left) sysfs_heartbeat_interval (precise)
[235.176505] Starting subtest: precise
[235.178592] Starting dynamic subtest: vecs0
[242.897288] Dynamic subtest vecs0: SUCCESS (7.719s)
[242.908180] Starting dynamic subtest: ccs0
[243.968896] Dynamic subtest ccs0: SUCCESS (1.069s)
[243.977231] Starting dynamic subtest: vcs0
[251.928284] Dynamic subtest vcs0: SUCCESS (7.957s)
[251.939641] Starting dynamic subtest: bcs0
[253.047535] Dynamic subtest bcs0: SUCCESS (1.115s)
[253.058314] Starting dynamic subtest: rcs0
[254.174827] Dynamic subtest rcs0: SUCCESS (1.128s)
[254.184628] Starting dynamic subtest: vcs1
[261.908990] Dynamic subtest vcs1: SUCCESS (7.732s)
[261.911707] Subtest precise: SUCCESS (26.733s)
[262.012732] [037/133] (759s left) gem_mmap_gtt (cpuset-big-copy-odd)
[262.074738] Subtest cpuset-big-copy-odd: SKIP (0.000s)
[262.138697] [038/133] (759s left) kms_content_protection (lic-type-0)
[262.285810] Starting subtest: lic-type-0
[262.290273] Subtest lic-type-0: SKIP (0.000s)
[262.574978] [039/133] (759s left) kms_plane_multiple (2x-tiling-yf)
[262.667309] Starting subtest: 2x-tiling-yf
[262.671257] Subtest 2x-tiling-yf: SKIP (0.000s)
[262.750951] [040/133] (759s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-mmap-gtt)
[262.843353] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-mmap-gtt
[262.847808] Subtest fbc-2p-scndscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[262.942082] [041/133] (758s left) perf_pmu (frequency)
[262.987326] Starting subtest: frequency
[262.991586] Starting dynamic subtest: gt0
[265.105376] Dynamic subtest gt0: SUCCESS (2.107s)
[265.115967] Starting dynamic subtest: idle-gt0
[265.609966] Dynamic subtest idle-gt0: SUCCESS (0.504s)
[265.621365] Starting dynamic subtest: gt1
[269.911604] Dynamic subtest gt1: SUCCESS (4.296s)
[269.920795] Starting dynamic subtest: idle-gt1
[270.417309] Dynamic subtest idle-gt1: SUCCESS (0.504s)
[270.419917] Subtest frequency: SUCCESS (7.431s)
[270.513795] [042/133] (751s left) kms_big_fb (y-tiled-64bpp-rotate-180)
[270.623311] Starting subtest: y-tiled-64bpp-rotate-180
[270.627596] Subtest y-tiled-64bpp-rotate-180: SKIP (0.000s)
[270.728771] [043/133] (751s left) kms_psr (fbc-psr2-cursor-mmap-gtt)
[270.817510] Starting subtest: fbc-psr2-cursor-mmap-gtt
[270.819438] Starting dynamic subtest: eDP-1
[270.823497] Dynamic subtest eDP-1: SKIP (0.000s)
[270.827556] Subtest fbc-psr2-cursor-mmap-gtt: SKIP (0.001s)
[270.891020] [044/133] (751s left) kms_psr2_sf (fbc-pr-cursor-plane-move-continuous-sf)
[270.982598] Starting subtest: fbc-pr-cursor-plane-move-continuous-sf
[270.986610] Subtest fbc-pr-cursor-plane-move-continuous-sf: SKIP (0.000s)
[271.051194] [045/133] (750s left) kms_psr (pr-sprite-plane-onoff)
[271.139128] Starting subtest: pr-sprite-plane-onoff
[271.143117] Subtest pr-sprite-plane-onoff: SKIP (0.000s)
[271.212385] [046/133] (750s left) kms_plane (pixel-format-y-tiled-modifier)
[271.300820] Starting subtest: pixel-format-y-tiled-modifier
[271.304658] Subtest pixel-format-y-tiled-modifier: SKIP (0.000s)
[271.371916] [047/133] (750s left) kms_plane (pixel-format-4-tiled-modifier)
[271.459665] Starting subtest: pixel-format-4-tiled-modifier
[271.488408] Starting dynamic subtest: pipe-A-plane-0
[272.143707] Dynamic subtest pipe-A-plane-0: SUCCESS (0.655s)
[272.152173] Starting dynamic subtest: pipe-A-plane-3
[272.577583] Dynamic subtest pipe-A-plane-3: SUCCESS (0.433s)
[272.591264] Starting dynamic subtest: pipe-A-plane-5
[272.595218] Dynamic subtest pipe-A-plane-5: SKIP (0.000s)
[273.701913] Starting dynamic subtest: pipe-B-plane-0
[274.349155] Dynamic subtest pipe-B-plane-0: SUCCESS (0.655s)
[274.357725] Starting dynamic subtest: pipe-B-plane-3
[274.793067] Dynamic subtest pipe-B-plane-3: SUCCESS (0.444s)
[274.801706] Starting dynamic subtest: pipe-B-plane-5
[274.805158] Dynamic subtest pipe-B-plane-5: SKIP (0.000s)
[275.106883] Subtest pixel-format-4-tiled-modifier: SUCCESS (3.646s)
[275.976034] [048/133] (746s left) gem_exec_balancer (full)
[276.045668] Starting subtest: full
[280.707720] Subtest full: SUCCESS (4.664s)
[281.022713] [049/133] (741s left) gem_exec_whisper (basic-contexts-forked-all)
[281.095407] Starting subtest: basic-contexts-forked-all
[304.011728] Subtest basic-contexts-forked-all: SUCCESS (22.913s)
[304.193697] [050/133] (718s left) syncobj_timeline (single-wait-for-submit-available-signaled)
[304.240940] Starting subtest: single-wait-for-submit-available-signaled
[304.243266] Subtest single-wait-for-submit-available-signaled: SUCCESS (0.000s)
[304.356742] [051/133] (717s left) gem_mmap_wc (set-cache-level)
[304.415805] Subtest set-cache-level: SKIP (0.000s)
[304.475378] [052/133] (717s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-render)
[304.581610] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-render
[304.585586] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-render: SKIP (0.000s)
[304.683715] [053/133] (717s left) kms_feature_discovery (psr1)
[304.769321] Starting subtest: psr1
[304.771346] Subtest psr1: SUCCESS (0.000s)
[304.838916] [054/133] (717s left) gem_basic (create-close)
[304.888265] Starting subtest: create-close
[304.892714] Subtest create-close: SUCCESS (0.000s)
[304.993365] [055/133] (717s left) gem_render_copy (y-tiled-to-vebox-y-tiled)
[305.047312] Starting subtest: y-tiled-to-vebox-y-tiled
[305.051907] Subtest y-tiled-to-vebox-y-tiled: SKIP (0.000s)
[305.229290] [056/133] (717s left) perf (enable-disable)
[305.318380] Starting subtest: enable-disable
[305.320819] Starting dynamic subtest: 0-rcs0
[307.587379] Dynamic subtest 0-rcs0: SUCCESS (2.270s)
[307.599792] Starting dynamic subtest: 1-vcs1
[312.062289] Dynamic subtest 1-vcs1: SUCCESS (4.474s)
[312.064564] Subtest enable-disable: SUCCESS (6.746s)
[312.111451] [057/133] (710s left) kms_psr2_sf (pr-cursor-plane-move-continuous-sf)
[312.216670] Starting subtest: pr-cursor-plane-move-continuous-sf
[312.221104] Subtest pr-cursor-plane-move-continuous-sf: SKIP (0.000s)
[312.279367] [058/133] (710s left) gem_exec_reloc (basic-gtt-read-noreloc)
[312.352746] Subtest basic-gtt-read-noreloc: SKIP (0.000s)
[312.437054] [059/133] (710s left) kms_ccs (crc-primary-suspend-4-tiled-dg2-rc-ccs-cc)
[312.530768] Starting subtest: crc-primary-suspend-4-tiled-dg2-rc-ccs-cc
[312.533047] Starting dynamic subtest: pipe-A-eDP-1
[312.542316] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[312.552189] Starting dynamic subtest: pipe-B-eDP-1
[312.561084] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[312.569909] Starting dynamic subtest: pipe-C-eDP-1
[312.578372] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[312.586758] Starting dynamic subtest: pipe-D-eDP-1
[312.596150] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[312.600155] Subtest crc-primary-suspend-4-tiled-dg2-rc-ccs-cc: SKIP (0.005s)
[314.844273] [060/133] (707s left) kms_flip (basic-plain-flip)
[314.944215] Starting subtest: basic-plain-flip
[314.946379] Starting dynamic subtest: A-eDP1
[316.650112] Dynamic subtest A-eDP1: SUCCESS (1.707s)
[316.661040] Starting dynamic subtest: B-eDP1
[318.376213] Dynamic subtest B-eDP1: SUCCESS (1.724s)
[318.387675] Starting dynamic subtest: C-eDP1
[320.004204] Dynamic subtest C-eDP1: SUCCESS (1.625s)
[320.014687] Starting dynamic subtest: D-eDP1
[321.636908] Dynamic subtest D-eDP1: SUCCESS (1.630s)
[321.643230] Subtest basic-plain-flip: SUCCESS (6.700s)
[322.809803] [061/133] (699s left) perf_pmu (init-busy)
[322.857733] Starting subtest: init-busy
[322.860287] Starting dynamic subtest: rcs0
[322.862624] Dynamic subtest rcs0: SUCCESS (0.001s)
[322.871210] Starting dynamic subtest: bcs0
[322.873133] Dynamic subtest bcs0: SUCCESS (0.000s)
[322.880991] Starting dynamic subtest: vcs0
[322.882981] Dynamic subtest vcs0: SUCCESS (0.001s)
[322.890807] Starting dynamic subtest: vcs1
[322.892811] Dynamic subtest vcs1: SUCCESS (0.001s)
[322.900719] Starting dynamic subtest: vecs0
[322.902678] Dynamic subtest vecs0: SUCCESS (0.001s)
[322.910598] Starting dynamic subtest: ccs0
[322.912594] Dynamic subtest ccs0: SUCCESS (0.000s)
[322.914538] Subtest init-busy: SUCCESS (0.008s)
[322.983472] [062/133] (699s left) gem_request_retire (retire-vma-not-inactive)
[323.038271] Starting subtest: retire-vma-not-inactive
[323.098964] Subtest retire-vma-not-inactive: SUCCESS (0.058s)
[323.227199] [063/133] (699s left) gem_ctx_sseu (engines)
[323.289783] Subtest engines: SKIP (0.000s)
[323.359839] [064/133] (699s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-0-async-flip)
[323.465647] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-0-async-flip
[323.470087] Subtest yf-tiled-max-hw-stride-64bpp-rotate-0-async-flip: SKIP (0.000s)
[323.557742] [065/133] (699s left) perf_pmu (all-busy-idle-check-all)
[323.595843] Starting subtest: all-busy-idle-check-all
[324.888317] Subtest all-busy-idle-check-all: SUCCESS (1.291s)
[325.036940] [066/133] (697s left) kms_cursor_legacy (cursor-vs-flip-atomic-transitions-varying-size)
[325.170453] Starting subtest: cursor-vs-flip-atomic-transitions-varying-size
[356.532235] Subtest cursor-vs-flip-atomic-transitions-varying-size: SUCCESS (31.359s)
[357.346306] [067/133] (665s left) gen9_exec_parse (unaligned-access)
[357.427364] Subtest unaligned-access: SKIP (0.000s)
[357.503797] [068/133] (665s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-fullscreen)
[357.602168] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-fullscreen
[357.606462] Subtest fbcpsr-2p-scndscrn-spr-indfb-fullscreen: SKIP (0.000s)
[357.704362] [069/133] (665s left) gen7_exec_parse (basic-rejected)
[357.767908] Subtest basic-rejected: SKIP (0.000s)
[357.834851] [070/133] (665s left) syncobj_eventfd (binary-wait-before-signal)
[357.888809] Starting subtest: binary-wait-before-signal
[357.918557] Subtest binary-wait-before-signal: SUCCESS (0.030s)
[358.008392] [071/133] (665s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-180)
[358.115298] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-180
[359.173093] Subtest x-tiled-max-hw-stride-32bpp-rotate-180: SUCCESS (1.059s)
[359.302779] [072/133] (663s left) vgem_basic (dmabuf-export)
[359.346789] Starting subtest: dmabuf-export
[359.376427] Subtest dmabuf-export: SUCCESS (0.033s)
[359.493914] [073/133] (663s left) kms_chamelium_edid (dp-edid-read)
[359.869164] Subtest dp-edid-read: SKIP (0.000s)
[360.657768] [074/133] (662s left) kms_cursor_crc (cursor-rapid-movement-256x256)
[360.888536] Starting subtest: cursor-rapid-movement-256x256
[360.894192] Starting dynamic subtest: pipe-A-eDP-1
[361.447512] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.556s)
[361.481766] Starting dynamic subtest: pipe-D-eDP-1
[362.690151] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.222s)
[362.692531] Subtest cursor-rapid-movement-256x256: SUCCESS (1.802s)
[363.543185] [075/133] (659s left) gem_spin_batch (legacy)
[363.606634] Starting subtest: legacy
[363.608883] Starting dynamic subtest: default
[366.842363] Dynamic subtest default: SUCCESS (3.234s)
[366.853644] Starting dynamic subtest: render
[370.079922] Dynamic subtest render: SUCCESS (3.234s)
[370.089841] Starting dynamic subtest: bsd
[373.320864] Dynamic subtest bsd: SUCCESS (3.236s)
[373.329421] Starting dynamic subtest: bsd1
[376.553364] Dynamic subtest bsd1: SUCCESS (3.230s)
[376.563218] Starting dynamic subtest: bsd2
[379.790313] Dynamic subtest bsd2: SUCCESS (3.236s)
[379.798625] Starting dynamic subtest: blt
[383.025670] Dynamic subtest blt: SUCCESS (3.232s)
[383.034812] Starting dynamic subtest: vebox
[386.262184] Dynamic subtest vebox: SUCCESS (3.235s)
[386.264872] Subtest legacy: SUCCESS (22.656s)
[386.967939] [076/133] (636s left) template (b)
[387.047995] Starting subtest: B
[387.050499] Subtest B: SUCCESS (0.000s)
[387.165250] [077/133] (636s left) kms_pipe_crc_basic (compare-crc-sanitycheck-xr24)
[387.260467] Starting subtest: compare-crc-sanitycheck-xr24
[387.262365] Starting dynamic subtest: pipe-A-eDP-1
[387.850386] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.591s)
[387.860017] Starting dynamic subtest: pipe-B-eDP-1
[389.097389] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.246s)
[389.107245] Starting dynamic subtest: pipe-C-eDP-1
[390.290754] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.188s)
[390.300157] Starting dynamic subtest: pipe-D-eDP-1
[391.507270] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.219s)
[391.509669] Subtest compare-crc-sanitycheck-xr24: SUCCESS (4.249s)
[392.362458] [078/133] (630s left) kms_big_fb (4-tiled-32bpp-rotate-90)
[392.463449] Starting subtest: 4-tiled-32bpp-rotate-90
[392.483267] Subtest 4-tiled-32bpp-rotate-90: SKIP (0.019s)
[392.598657] [079/133] (630s left) kms_rotation_crc (bad-tiling)
[392.682939] Starting subtest: bad-tiling
[392.687384] Subtest bad-tiling: SKIP (0.001s)
[392.759728] [080/133] (630s left) i915_pm_rps (min-max-config-idle)
[392.812753] Starting subtest: min-max-config-idle
[392.817278] Subtest min-max-config-idle: SKIP (0.000s)
[392.945826] [081/133] (630s left) gem_exec_params (invalid-fence-in-submit)
[392.994656] Starting subtest: invalid-fence-in-submit
[392.999751] Subtest invalid-fence-in-submit: SUCCESS (0.003s)
[393.109991] [082/133] (630s left) dmabuf_sync_file (import-multiple-read-only)
[393.150303] Starting subtest: import-multiple-read-only
[393.152694] Subtest import-multiple-read-only: SUCCESS (0.003s)
[393.205508] [083/133] (630s left) i915_pm_rps (thresholds-park)
[393.261613] Starting subtest: thresholds-park
[393.266064] Subtest thresholds-park: SKIP (0.000s)
[393.382018] [084/133] (630s left) kms_ccs (crc-primary-basic-y-tiled-gen12-rc-ccs-cc)
[393.469386] Starting subtest: crc-primary-basic-y-tiled-gen12-rc-ccs-cc
[393.471368] Starting dynamic subtest: pipe-A-eDP-1
[393.489949] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[393.500492] Starting dynamic subtest: pipe-B-eDP-1
[393.517990] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[393.526373] Starting dynamic subtest: pipe-C-eDP-1
[393.544519] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[393.552966] Starting dynamic subtest: pipe-D-eDP-1
[393.570950] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[393.574545] Subtest crc-primary-basic-y-tiled-gen12-rc-ccs-cc: SKIP (0.006s)
[395.717987] [085/133] (627s left) gem_pxp (display-protected-crc)
[395.839297] Starting subtest: display-protected-crc
[397.445872] Subtest display-protected-crc: SUCCESS (1.610s)
[397.562354] [086/133] (626s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-render)
[397.649285] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-render
[404.804344] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-render: SUCCESS (7.158s)
[404.961700] [087/133] (618s left) gem_exec_fence (concurrent)
[405.149638] Starting subtest: concurrent
[405.154596] Subtest concurrent: SKIP (0.000s)
[407.008812] [088/133] (616s left) gem_exec_schedule (semaphore-user)
[407.091038] Starting subtest: semaphore-user
[407.142235] Subtest semaphore-user: SUCCESS (0.058s)
[408.959338] [089/133] (614s left) kms_dp_link_training (non-uhbr-sst)
[409.050920] Starting subtest: non-uhbr-sst
[409.059627] Subtest non-uhbr-sst: SKIP (0.000s)
[409.121019] [090/133] (614s left) perf_pmu (semaphore-wait)
[409.161360] Starting subtest: semaphore-wait
[409.163546] Starting dynamic subtest: rcs0
[409.675162] Dynamic subtest rcs0: SUCCESS (0.514s)
[409.687595] Starting dynamic subtest: bcs0
[410.188396] Dynamic subtest bcs0: SUCCESS (0.510s)
[410.202883] Starting dynamic subtest: vcs0
[410.703648] Dynamic subtest vcs0: SUCCESS (0.511s)
[410.716228] Starting dynamic subtest: vcs1
[411.218392] Dynamic subtest vcs1: SUCCESS (0.511s)
[411.230737] Starting dynamic subtest: vecs0
[411.733076] Dynamic subtest vecs0: SUCCESS (0.510s)
[411.745870] Starting dynamic subtest: ccs0
[412.249191] Dynamic subtest ccs0: SUCCESS (0.514s)
[412.251962] Subtest semaphore-wait: SUCCESS (3.091s)
[412.365392] [091/133] (611s left) kms_plane_scaling (planes-downscale-factor-0-75)
[412.456915] Starting subtest: planes-downscale-factor-0-75
[412.459230] Starting dynamic subtest: pipe-A
[412.478894] Dynamic subtest pipe-A: SKIP (0.017s)
[412.488483] Starting dynamic subtest: pipe-B
[412.508051] Dynamic subtest pipe-B: SKIP (0.030s)
[412.517053] Starting dynamic subtest: pipe-C
[412.539531] Dynamic subtest pipe-C: SKIP (0.031s)
[412.548602] Starting dynamic subtest: pipe-D
[412.570450] Dynamic subtest pipe-D: SKIP (0.030s)
[412.574200] Subtest planes-downscale-factor-0-75: SKIP (0.110s)
[412.678221] [092/133] (611s left) kms_frontbuffer_tracking (fbcpsr-2p-shrfb-fliptrack-mmap-gtt)
[412.779214] Starting subtest: fbcpsr-2p-shrfb-fliptrack-mmap-gtt
[412.783582] Subtest fbcpsr-2p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s)
[412.870514] [093/133] (611s left) syncobj_timeline (multi-wait-submitted-signaled)
[412.925477] Starting subtest: multi-wait-submitted-signaled
[412.928050] Subtest multi-wait-submitted-signaled: SUCCESS (0.001s)
[413.035020] [094/133] (611s left) gem_userptr_blits (mmap-offset-banned)
[413.101798] Starting subtest: mmap-offset-banned
[413.104152] Starting dynamic subtest: wb
[413.106371] Dynamic subtest wb: SUCCESS (0.000s)
[413.115931] Starting dynamic subtest: wc
[413.118127] Dynamic subtest wc: SUCCESS (0.000s)
[413.126887] Starting dynamic subtest: uc
[413.129068] Dynamic subtest uc: SUCCESS (0.000s)
[413.131202] Subtest mmap-offset-banned: SUCCESS (0.002s)
[413.241392] [095/133] (610s left) gem_ctx_persistence (engines-hostile-preempt)
[413.292725] Starting subtest: engines-hostile-preempt
[413.294637] Starting dynamic subtest: rcs0
[413.363700] Dynamic subtest rcs0: SUCCESS (0.070s)
[413.375522] Starting dynamic subtest: bcs0
[413.409677] Dynamic subtest bcs0: SUCCESS (0.044s)
[413.420305] Starting dynamic subtest: vcs0
[414.927930] Dynamic subtest vcs0: SUCCESS (1.515s)
[414.940116] Starting dynamic subtest: vcs1
[416.913371] Dynamic subtest vcs1: SUCCESS (1.982s)
[416.925665] Starting dynamic subtest: vecs0
[418.901893] Dynamic subtest vecs0: SUCCESS (1.986s)
[418.913928] Starting dynamic subtest: ccs0
[418.952834] Dynamic subtest ccs0: SUCCESS (0.049s)
[418.955496] Subtest engines-hostile-preempt: SUCCESS (5.660s)
[419.037613] [096/133] (605s left) kms_invalid_mode (bad-htotal)
[419.130090] Starting subtest: bad-htotal
[419.132510] Starting dynamic subtest: pipe-A-eDP-1
[419.411303] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.284s)
[419.422230] Starting dynamic subtest: pipe-B-eDP-1
[419.424110] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[419.432427] Starting dynamic subtest: pipe-C-eDP-1
[419.434840] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[419.443579] Starting dynamic subtest: pipe-D-eDP-1
[419.445909] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[419.448186] Subtest bad-htotal: SUCCESS (0.290s)
[420.266367] [097/133] (603s left) kms_atomic (plane-invalid-params)
[420.366078] Starting subtest: plane-invalid-params
[420.368345] Starting dynamic subtest: pipe-A-eDP-1
[420.770181] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.403s)
[420.772112] Subtest plane-invalid-params: SUCCESS (0.404s)
[421.595253] [098/133] (602s left) kms_pm_dc (dc6-dpms)
[422.697653] Starting subtest: dc6-dpms
[424.770094] Subtest dc6-dpms: SUCCESS (2.071s)
[424.846714] [099/133] (599s left) gem_pxp (hw-rejects-pxp-context)
[424.895321] Starting subtest: hw-rejects-pxp-context
[424.899908] Subtest hw-rejects-pxp-context: SKIP (0.000s)
[424.989640] [100/133] (599s left) kms_chamelium_color (ctm-0-50)
[425.073679] Subtest ctm-0-50: SKIP (0.000s)
[425.124203] [101/133] (599s left) syncobj_wait (wait-delayed-signal)
[425.178969] Starting subtest: wait-delayed-signal
[425.282302] Subtest wait-delayed-signal: SUCCESS (0.103s)
[425.363512] [102/133] (599s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-shrfb-pgflip-blt)
[425.473297] Starting subtest: fbcpsr-2p-primscrn-shrfb-pgflip-blt
[425.477632] Subtest fbcpsr-2p-primscrn-shrfb-pgflip-blt: SKIP (0.000s)
[425.576416] [103/133] (598s left) kms_frontbuffer_tracking (fbcpsr-2p-pri-indfb-multidraw)
[425.668140] Starting subtest: fbcpsr-2p-pri-indfb-multidraw
[425.672081] Subtest fbcpsr-2p-pri-indfb-multidraw: SKIP (0.000s)
[425.771313] [104/133] (598s left) kms_prop_blob (basic)
[425.831607] Starting subtest: basic
[425.833926] Subtest basic: SUCCESS (0.000s)
[425.951496] [105/133] (598s left) gem_exec_fence (syncobj-channel)
[426.365556] Starting subtest: syncobj-channel
[427.386970] Subtest syncobj-channel: SUCCESS (1.019s)
[427.984410] [106/133] (596s left) kms_psr (psr-sprite-render)
[428.070623] Starting subtest: psr-sprite-render
[428.072751] Starting dynamic subtest: eDP-1
[429.851830] Dynamic subtest eDP-1: SUCCESS (1.779s)
[429.854126] Subtest psr-sprite-render: SUCCESS (1.780s)
[430.682129] [107/133] (593s left) gem_tiled_partial_pwrite_pread (writes-after-reads)
[430.744431] Subtest writes-after-reads: SKIP (0.000s)
[430.824345] [108/133] (593s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-pwrite)
[430.929950] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-pwrite
[430.934220] Subtest fbc-2p-primscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[431.039303] [109/133] (593s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-0-async-flip)
[431.133702] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-0-async-flip
[431.946750] Subtest 4-tiled-max-hw-stride-64bpp-rotate-0-async-flip: SUCCESS (0.814s)
[432.101447] [110/133] (592s left) kms_busy (extended-modeset-hang-newfb)
[432.201271] Starting subtest: extended-modeset-hang-newfb
[432.203193] Starting dynamic subtest: pipe-A
[466.796298] Dynamic subtest pipe-A: SUCCESS (34.594s)
[466.806202] Starting dynamic subtest: pipe-D
[489.814100] Dynamic subtest pipe-D: SUCCESS (23.016s)
[489.816502] Subtest extended-modeset-hang-newfb: SUCCESS (57.615s)
[490.618555] [111/133] (534s left) kms_frontbuffer_tracking (psr-2p-scndscrn-indfb-pgflip-blt)
[490.731853] Starting subtest: psr-2p-scndscrn-indfb-pgflip-blt
[490.736431] Subtest psr-2p-scndscrn-indfb-pgflip-blt: SKIP (0.000s)
[490.837346] [112/133] (533s left) kms_cursor_crc (cursor-onscreen-32x10)
[491.007843] Starting subtest: cursor-onscreen-32x10
[491.057700] Subtest cursor-onscreen-32x10: SKIP (0.044s)
[491.339694] [113/133] (533s left) kms_3d (basic)
[491.402832] Starting subtest: basic
[493.394326] Subtest basic: SUCCESS (1.994s)
[493.880312] [114/133] (531s left) syncobj_basic (bad-fd-to-handle)
[493.934499] Starting subtest: bad-fd-to-handle
[493.936674] Subtest bad-fd-to-handle: SUCCESS (0.000s)
[494.026982] [115/133] (530s left) kms_color_pipeline (plane-lut1d-lut1d)
[494.117239] Starting subtest: plane-lut1d-lut1d
[494.240817] Starting dynamic subtest: pipe-A-plane-0
[494.572926] Dynamic subtest pipe-A-plane-0: FAIL (0.160s)
[494.584373] Starting dynamic subtest: pipe-A-plane-1
[494.800503] Dynamic subtest pipe-A-plane-1: FAIL (0.169s)
[494.810153] Starting dynamic subtest: pipe-A-plane-2
[495.020372] Dynamic subtest pipe-A-plane-2: FAIL (0.177s)
[495.901094] Starting dynamic subtest: pipe-B-plane-0
[496.320279] Dynamic subtest pipe-B-plane-0: FAIL (0.166s)
[496.331076] Starting dynamic subtest: pipe-B-plane-1
[496.638752] Dynamic subtest pipe-B-plane-1: FAIL (0.174s)
[496.650286] Starting dynamic subtest: pipe-B-plane-2
[496.951641] Dynamic subtest pipe-B-plane-2: FAIL (0.177s)
[497.625575] Starting dynamic subtest: pipe-C-plane-0
[498.109440] Dynamic subtest pipe-C-plane-0: FAIL (0.129s)
[498.120346] Starting dynamic subtest: pipe-C-plane-1
[498.506867] Dynamic subtest pipe-C-plane-1: FAIL (0.594s)
[498.522155] Starting dynamic subtest: pipe-C-plane-2
[498.889060] Dynamic subtest pipe-C-plane-2: FAIL (0.146s)
[499.728491] Starting dynamic subtest: pipe-D-plane-0
[500.335687] Dynamic subtest pipe-D-plane-0: FAIL (0.151s)
[500.347448] Starting dynamic subtest: pipe-D-plane-1
[500.807886] Dynamic subtest pipe-D-plane-1: FAIL (0.609s)
[500.819041] Starting dynamic subtest: pipe-D-plane-2
[501.257557] Dynamic subtest pipe-D-plane-2: FAIL (0.551s)
[501.346716] Subtest plane-lut1d-lut1d: FAIL (7.231s)
[502.141034] [116/133] (522s left) kms_flip_scaled_crc (flip-32bpp-yftile-to-32bpp-yftileccs-upscaling)
[502.234906] Starting subtest: flip-32bpp-yftile-to-32bpp-yftileccs-upscaling
[502.239060] Subtest flip-32bpp-yftile-to-32bpp-yftileccs-upscaling: SKIP (0.000s)
[502.307906] [117/133] (522s left) gem_close_race (basic-threads)
[502.368819] Starting subtest: basic-threads
[503.827296] Subtest basic-threads: SUCCESS (1.458s)
[504.014620] [118/133] (521s left) kms_psr (psr2-cursor-plane-move)
[504.098916] Starting subtest: psr2-cursor-plane-move
[504.101233] Starting dynamic subtest: eDP-1
[505.780515] Dynamic subtest eDP-1: SUCCESS (1.682s)
[505.782876] Subtest psr2-cursor-plane-move: SUCCESS (1.683s)
[506.649187] [119/133] (518s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-move)
[506.743149] Starting subtest: psr-1p-primscrn-spr-indfb-move
[514.212890] Subtest psr-1p-primscrn-spr-indfb-move: SUCCESS (7.472s)
[514.362390] [120/133] (510s left) kms_atomic_transition (plane-all-modeset-transition-fencing-internal-panels)
[514.471060] Starting subtest: plane-all-modeset-transition-fencing-internal-panels
[514.472927] Starting dynamic subtest: pipe-A-eDP-1
[515.759562] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.287s)
[516.051223] Starting dynamic subtest: pipe-B-eDP-1
[517.062561] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.020s)
[517.330055] Subtest plane-all-modeset-transition-fencing-internal-panels: SUCCESS (2.859s)
[518.139460] [121/133] (507s left) gem_userptr_blits (process-exit-busy)
[518.202068] Starting subtest: process-exit-busy
[518.219666] Subtest process-exit-busy: SUCCESS (0.018s)
[518.347035] [122/133] (506s left) gem_exec_schedule (pi-common)
[518.526681] Starting subtest: pi-common
[518.528865] Starting dynamic subtest: rcs0
[518.558265] Dynamic subtest rcs0: SUCCESS (0.033s)
[518.567396] Starting dynamic subtest: bcs0
[518.599309] Dynamic subtest bcs0: SUCCESS (0.040s)
[518.611950] Starting dynamic subtest: vcs0
[518.631902] Dynamic subtest vcs0: SUCCESS (0.032s)
[518.644251] Starting dynamic subtest: vcs1
[518.663869] Dynamic subtest vcs1: SUCCESS (0.031s)
[518.676130] Starting dynamic subtest: vecs0
[518.692066] Dynamic subtest vecs0: SUCCESS (0.027s)
[518.705086] Starting dynamic subtest: ccs0
[518.720086] Dynamic subtest ccs0: SUCCESS (0.027s)
[518.722213] Subtest pi-common: SUCCESS (0.196s)
[518.941174] [123/133] (506s left) kms_lease (lease-unleased-connector)
[519.037185] Starting subtest: lease-unleased-connector
[519.039528] Starting dynamic subtest: pipe-A-eDP-1
[519.044541] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.007s)
[519.054435] Starting dynamic subtest: pipe-B-eDP-1
[519.056783] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.011s)
[519.066781] Starting dynamic subtest: pipe-C-eDP-1
[519.069521] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.008s)
[519.079167] Starting dynamic subtest: pipe-D-eDP-1
[519.081087] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.007s)
[519.082878] Subtest lease-unleased-connector: SUCCESS (0.040s)
[519.184183] [124/133] (506s left) gem_ctx_persistence (legacy-engines-hang)
[519.252675] Starting subtest: legacy-engines-hang
[519.255098] Starting dynamic subtest: render
[519.378675] Dynamic subtest render: SUCCESS (0.125s)
[519.393623] Starting dynamic subtest: bsd1
[519.482541] Dynamic subtest bsd1: SUCCESS (0.101s)
[519.498904] Starting dynamic subtest: bsd2
[519.585581] Dynamic subtest bsd2: SUCCESS (0.100s)
[519.599558] Starting dynamic subtest: blt
[519.684818] Dynamic subtest blt: SUCCESS (0.096s)
[519.698802] Starting dynamic subtest: vebox
[519.783921] Dynamic subtest vebox: SUCCESS (0.096s)
[519.786640] Subtest legacy-engines-hang: SUCCESS (0.532s)
[519.864072] [125/133] (505s left) kms_big_fb (x-tiled-32bpp-rotate-90)
[519.952298] Starting subtest: x-tiled-32bpp-rotate-90
[519.972091] Subtest x-tiled-32bpp-rotate-90: SKIP (0.019s)
[520.076843] [126/133] (505s left) api_intel_bb (object-reloc-keep-cache)
[520.130546] Starting subtest: object-reloc-keep-cache
[520.134305] Subtest object-reloc-keep-cache: SKIP (0.003s)
[520.247476] [127/133] (505s left) kms_flip (dpms-off-confusion)
[520.346981] Starting subtest: dpms-off-confusion
[520.348835] Starting dynamic subtest: A-eDP1
[529.007146] Dynamic subtest A-eDP1: SUCCESS (8.660s)
[529.025829] Starting dynamic subtest: B-eDP1
[537.718694] Dynamic subtest B-eDP1: SUCCESS (8.706s)
[537.729174] Starting dynamic subtest: C-eDP1
[546.396947] Dynamic subtest C-eDP1: SUCCESS (8.677s)
[546.410683] Starting dynamic subtest: D-eDP1
[555.108323] Dynamic subtest D-eDP1: SUCCESS (8.709s)
[555.113744] Subtest dpms-off-confusion: SUCCESS (34.767s)
[556.351656] [128/133] (469s left) prime_mmap (test_correct_cpu_write)
[556.415438] Starting subtest: test_correct_cpu_write
[556.417629] Starting dynamic subtest: test_correct_cpu_write-smem
[556.419830] Dynamic subtest test_correct_cpu_write-smem: SUCCESS (0.000s)
[556.422078] Subtest test_correct_cpu_write: SUCCESS (0.001s)
[556.526836] [129/133] (468s left) kms_chamelium_hpd (hdmi-hpd-for-each-pipe)
[556.909581] Subtest hdmi-hpd-for-each-pipe: SKIP (0.000s)
[557.722675] [130/133] (467s left) kms_frontbuffer_tracking (psr-1p-primscrn-indfb-plflip-blt)
[557.824718] Starting subtest: psr-1p-primscrn-indfb-plflip-blt
[565.114101] Subtest psr-1p-primscrn-indfb-plflip-blt: SUCCESS (7.291s)
[565.244661] [131/133] (460s left) gem_create (create-ext-cpu-access-big)
[565.418433] Starting subtest: create-ext-cpu-access-big
[565.423879] Subtest create-ext-cpu-access-big: SKIP (0.002s)
[565.493654] [132/133] (460s left) syncobj_wait (single-wait-all-for-submit-unsubmitted)
[565.550045] Starting subtest: single-wait-all-for-submit-unsubmitted
[565.650063] Subtest single-wait-all-for-submit-unsubmitted: SUCCESS (0.101s)
[565.763760] [133/133] (459s left) i915_pm_freq_api (freq-reset)
[565.823978] Starting subtest: freq-reset
[565.826452] Starting dynamic subtest: gt0
[566.015756] Dynamic subtest gt0: SUCCESS (0.189s)
[566.024420] Starting dynamic subtest: gt1
[566.178865] Dynamic subtest gt1: SUCCESS (0.163s)
[566.181897] Subtest freq-reset: SUCCESS (0.354s)
[566.262651] Closing watchdogs
results: parsing output: 0/ for test: kms_frontbuffer_tracking
results: parsing output: 1/ for test: kms_frontbuffer_tracking
results: parsing output: 2/ for test: gem_fenced_exec_thrash
results: parsing output: 3/ for test: kms_rotation_crc
results: parsing output: 4/ for test: kms_psr
results: parsing output: 5/ for test: kms_frontbuffer_tracking
results: parsing output: 6/ for test: kms_cursor_legacy
results: parsing output: 7/ for test: kms_psr2_sf
results: parsing output: 8/ for test: gem_eio
results: parsing output: 9/ for test: perf
results: parsing output: 10/ for test: syncobj_timeline
results: parsing output: 11/ for test: kms_universal_plane
results: parsing output: 12/ for test: gem_mmap_offset
results: parsing output: 13/ for test: kms_vblank
results: parsing output: 14/ for test: kms_flip
results: parsing output: 15/ for test: kms_flip
results: parsing output: 16/ for test: api_intel_allocator
results: parsing output: 17/ for test: perf_pmu
results: parsing output: 18/ for test: kms_ccs
results: parsing output: 19/ for test: kms_frontbuffer_tracking
results: parsing output: 20/ for test: fbdev
results: parsing output: 21/ for test: kms_flip_scaled_crc
results: parsing output: 22/ for test: gem_madvise
results: parsing output: 23/ for test: syncobj_wait
results: parsing output: 24/ for test: kms_ccs
results: parsing output: 25/ for test: kms_flip
results: parsing output: 26/ for test: gem_gpgpu_fill
results: parsing output: 27/ for test: kms_frontbuffer_tracking
results: parsing output: 28/ for test: kms_addfb_basic
results: parsing output: 29/ for test: syncobj_timeline
results: parsing output: 30/ for test: kms_frontbuffer_tracking
results: parsing output: 31/ for test: kms_flip_scaled_crc
results: parsing output: 32/ for test: gem_exec_reloc
results: parsing output: 33/ for test: gem_tiled_blits
results: parsing output: 34/ for test: kms_getfb
results: parsing output: 35/ for test: sysfs_heartbeat_interval
results: parsing output: 36/ for test: gem_mmap_gtt
results: parsing output: 37/ for test: kms_content_protection
results: parsing output: 38/ for test: kms_plane_multiple
results: parsing output: 39/ for test: kms_frontbuffer_tracking
results: parsing output: 40/ for test: perf_pmu
results: parsing output: 41/ for test: kms_big_fb
results: parsing output: 42/ for test: kms_psr
results: parsing output: 43/ for test: kms_psr2_sf
results: parsing output: 44/ for test: kms_psr
results: parsing output: 45/ for test: kms_plane
results: parsing output: 46/ for test: kms_plane
results: parsing output: 47/ for test: gem_exec_balancer
results: parsing output: 48/ for test: gem_exec_whisper
results: parsing output: 49/ for test: syncobj_timeline
results: parsing output: 50/ for test: gem_mmap_wc
results: parsing output: 51/ for test: kms_frontbuffer_tracking
results: parsing output: 52/ for test: kms_feature_discovery
results: parsing output: 53/ for test: gem_basic
results: parsing output: 54/ for test: gem_render_copy
results: parsing output: 55/ for test: perf
results: parsing output: 56/ for test: kms_psr2_sf
results: parsing output: 57/ for test: gem_exec_reloc
results: parsing output: 58/ for test: kms_ccs
results: parsing output: 59/ for test: kms_flip
results: parsing output: 60/ for test: perf_pmu
results: parsing output: 61/ for test: gem_request_retire
results: parsing output: 62/ for test: gem_ctx_sseu
results: parsing output: 63/ for test: kms_big_fb
results: parsing output: 64/ for test: perf_pmu
results: parsing output: 65/ for test: kms_cursor_legacy
results: parsing output: 66/ for test: gen9_exec_parse
results: parsing output: 67/ for test: kms_frontbuffer_tracking
results: parsing output: 68/ for test: gen7_exec_parse
results: parsing output: 69/ for test: syncobj_eventfd
results: parsing output: 70/ for test: kms_big_fb
results: parsing output: 71/ for test: vgem_basic
results: parsing output: 72/ for test: kms_chamelium_edid
results: parsing output: 73/ for test: kms_cursor_crc
results: parsing output: 74/ for test: gem_spin_batch
results: parsing output: 75/ for test: template
results: parsing output: 76/ for test: kms_pipe_crc_basic
results: parsing output: 77/ for test: kms_big_fb
results: parsing output: 78/ for test: kms_rotation_crc
results: parsing output: 79/ for test: i915_pm_rps
results: parsing output: 80/ for test: gem_exec_params
results: parsing output: 81/ for test: dmabuf_sync_file
results: parsing output: 82/ for test: i915_pm_rps
results: parsing output: 83/ for test: kms_ccs
results: parsing output: 84/ for test: gem_pxp
results: parsing output: 85/ for test: kms_frontbuffer_tracking
results: parsing output: 86/ for test: gem_exec_fence
results: parsing output: 87/ for test: gem_exec_schedule
results: parsing output: 88/ for test: kms_dp_link_training
results: parsing output: 89/ for test: perf_pmu
results: parsing output: 90/ for test: kms_plane_scaling
results: parsing output: 91/ for test: kms_frontbuffer_tracking
results: parsing output: 92/ for test: syncobj_timeline
results: parsing output: 93/ for test: gem_userptr_blits
results: parsing output: 94/ for test: gem_ctx_persistence
results: parsing output: 95/ for test: kms_invalid_mode
results: parsing output: 96/ for test: kms_atomic
results: parsing output: 97/ for test: kms_pm_dc
results: parsing output: 98/ for test: gem_pxp
results: parsing output: 99/ for test: kms_chamelium_color
results: parsing output: 100/ for test: syncobj_wait
results: parsing output: 101/ for test: kms_frontbuffer_tracking
results: parsing output: 102/ for test: kms_frontbuffer_tracking
results: parsing output: 103/ for test: kms_prop_blob
results: parsing output: 104/ for test: gem_exec_fence
results: parsing output: 105/ for test: kms_psr
results: parsing output: 106/ for test: gem_tiled_partial_pwrite_pread
results: parsing output: 107/ for test: kms_frontbuffer_tracking
results: parsing output: 108/ for test: kms_big_fb
results: parsing output: 109/ for test: kms_busy
results: parsing output: 110/ for test: kms_frontbuffer_tracking
results: parsing output: 111/ for test: kms_cursor_crc
results: parsing output: 112/ for test: kms_3d
results: parsing output: 113/ for test: syncobj_basic
results: parsing output: 114/ for test: kms_color_pipeline
results: parsing output: 115/ for test: kms_flip_scaled_crc
results: parsing output: 116/ for test: gem_close_race
results: parsing output: 117/ for test: kms_psr
results: parsing output: 118/ for test: kms_frontbuffer_tracking
results: parsing output: 119/ for test: kms_atomic_transition
results: parsing output: 120/ for test: gem_userptr_blits
results: parsing output: 121/ for test: gem_exec_schedule
results: parsing output: 122/ for test: kms_lease
results: parsing output: 123/ for test: gem_ctx_persistence
results: parsing output: 124/ for test: kms_big_fb
results: parsing output: 125/ for test: api_intel_bb
results: parsing output: 126/ for test: kms_flip
results: parsing output: 127/ for test: prime_mmap
results: parsing output: 128/ for test: kms_chamelium_hpd
results: parsing output: 129/ for test: kms_frontbuffer_tracking
results: parsing output: 130/ for test: gem_create
results: parsing output: 131/ for test: syncobj_wait
results: parsing output: 132/ for test: i915_pm_freq_api
Done.