[56.856876] Initializing watchdogs
[56.856918]   /dev/watchdog0
[56.874141] [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]
[56.878472] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[56.880906] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[56.884241] [001/134] (960s left) kms_frontbuffer_tracking (psr-1p-primscrn-indfb-msflip-blt)
[57.004204] Starting subtest: psr-1p-primscrn-indfb-msflip-blt
[64.393193] Subtest psr-1p-primscrn-indfb-msflip-blt: SUCCESS (7.370s)
[64.573012] [002/134] (952s left) kms_chamelium_frames (dp-crc-single)
[64.969339] Subtest dp-crc-single: SKIP (0.000s)
[65.740977] [003/134] (951s left) kms_ccs (bad-rotation-90-4-tiled-bmg-ccs)
[65.834471] Starting subtest: bad-rotation-90-4-tiled-bmg-ccs
[65.839464] Subtest bad-rotation-90-4-tiled-bmg-ccs: SKIP (0.000s)
[67.055967] [004/134] (950s left) kms_prop_blob (invalid-get-prop)
[67.282443] Starting subtest: invalid-get-prop
[67.284783] Subtest invalid-get-prop: SUCCESS (0.000s)
[67.519339] [005/134] (950s left) syncobj_wait (reset-unsignaled)
[67.622185] Starting subtest: reset-unsignaled
[67.624697] Subtest reset-unsignaled: SUCCESS (0.000s)
[67.817194] [006/134] (949s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-blt)
[67.924423] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-blt
[67.928565] Subtest psr-2p-scndscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[68.062444] [007/134] (949s left) i915_module_load (resize-bar)
[68.096418] Starting subtest: resize-bar
[68.106759] Subtest resize-bar: SKIP (0.008s)
[68.145590] [008/134] (949s left) syncobj_timeline (signal-point-0)
[68.204703] Starting subtest: signal-point-0
[68.206943] Subtest signal-point-0: SUCCESS (0.000s)
[68.311797] [009/134] (949s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip)
[68.408287] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip
[68.412185] Subtest yf-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip: SKIP (0.000s)
[68.521168] [010/134] (949s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-mmap-wc)
[68.612081] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-mmap-wc
[68.616055] Subtest fbc-2p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[68.737574] [011/134] (949s left) gem_partial_pwrite_pread (reads-uncached)
[68.793632] Subtest reads-uncached: SKIP (0.000s)
[68.877835] [012/134] (948s left) api_intel_allocator (fork-simple-once)
[68.940117] Starting subtest: fork-simple-once
[68.957114] Subtest fork-simple-once: SUCCESS (0.018s)
[69.108048] [013/134] (948s left) syncobj_wait (multi-wait-for-submit-unsubmitted-submitted-signaled)
[69.166386] Starting subtest: multi-wait-for-submit-unsubmitted-submitted-signaled
[69.168358] Subtest multi-wait-for-submit-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[69.297814] [014/134] (948s left) kms_atomic (plane-cursor-legacy)
[69.391049] Starting subtest: plane-cursor-legacy
[69.393093] Starting dynamic subtest: pipe-A-eDP-1
[69.778163] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.385s)
[69.780651] Subtest plane-cursor-legacy: SUCCESS (0.386s)
[70.641045] [015/134] (947s left) kms_psr (psr-primary-mmap-gtt)
[70.750371] Starting subtest: psr-primary-mmap-gtt
[70.752793] Starting dynamic subtest: eDP-1
[72.233641] Dynamic subtest eDP-1: SKIP (1.478s)
[72.238254] Subtest psr-primary-mmap-gtt: SKIP (1.479s)
[72.397456] [016/134] (945s left) gem_tiled_blits (interruptible)
[72.466856] Subtest interruptible: SKIP (0.000s)
[72.558390] [017/134] (945s left) gem_flink_basic (bad-open)
[72.620089] Starting subtest: bad-open
[72.622487] Subtest bad-open: SUCCESS (0.000s)
[72.738305] [018/134] (945s left) kms_cursor_crc (cursor-onscreen-256x256)
[73.001793] Starting subtest: cursor-onscreen-256x256
[73.006512] Starting dynamic subtest: pipe-A-eDP-1
[75.141300] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.132s)
[75.171325] Starting dynamic subtest: pipe-D-eDP-1
[77.916700] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.751s)
[77.919126] Subtest cursor-onscreen-256x256: SUCCESS (4.912s)
[78.740246] [019/134] (939s left) kms_plane_scaling (plane-downscale-factor-0-75-with-rotation)
[78.838927] Starting subtest: plane-downscale-factor-0-75-with-rotation
[78.841261] Starting dynamic subtest: pipe-A
[79.066813] Dynamic subtest pipe-A: SUCCESS (0.230s)
[79.075978] Starting dynamic subtest: pipe-B
[80.413448] Dynamic subtest pipe-B: SUCCESS (1.346s)
[80.422570] Starting dynamic subtest: pipe-C
[81.758255] Dynamic subtest pipe-C: SUCCESS (1.344s)
[81.767904] Starting dynamic subtest: pipe-D
[83.077619] Dynamic subtest pipe-D: SUCCESS (1.319s)
[83.080044] Subtest plane-downscale-factor-0-75-with-rotation: SUCCESS (4.241s)
[84.271013] [020/134] (933s left) gem_pxp (display-protected-crc)
[84.410874] Starting subtest: display-protected-crc
[86.023137] Subtest display-protected-crc: SUCCESS (1.615s)
[86.170816] [021/134] (932s left) kms_plane_alpha_blend (coverage-7efc)
[86.277453] Starting subtest: coverage-7efc
[86.568933] Starting dynamic subtest: pipe-A-eDP-1
[87.125435] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.554s)
[87.150389] Starting dynamic subtest: pipe-D-eDP-1
[88.478758] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.333s)
[88.481223] Subtest coverage-7efc: SUCCESS (2.199s)
[89.329176] [022/134] (928s left) kms_chamelium_hpd (dp-hpd-storm)
[89.735174] Subtest dp-hpd-storm: SKIP (0.000s)
[90.535834] [023/134] (927s left) gem_eio (in-flight-10ms)
[90.763442] Starting subtest: in-flight-10ms
[99.842586] Subtest in-flight-10ms: SUCCESS (9.078s)
[100.029053] [FACT gem_eio (in-flight-10ms)] new: kernel.kmod_is_loaded.vgem: true
[100.032070] [024/134] (918s left) kms_frontbuffer_tracking (fbcpsr-abgr161616f-draw-mmap-gtt)
[100.127734] Starting subtest: fbcpsr-abgr161616f-draw-mmap-gtt
[100.131708] Subtest fbcpsr-abgr161616f-draw-mmap-gtt: SKIP (0.000s)
[100.255181] [025/134] (918s left) i915_selftest (perf)
[102.152919] Starting subtest: perf
[102.155656] Starting dynamic subtest: engine_cs
[106.590716] Dynamic subtest engine_cs: SUCCESS (4.441s)
[106.598583] Starting dynamic subtest: request
[113.970394] Dynamic subtest request: SUCCESS (7.378s)
[113.984248] Starting dynamic subtest: migrate
[116.944392] Dynamic subtest migrate: SUCCESS (2.972s)
[116.952909] Starting dynamic subtest: region
[123.309751] Dynamic subtest region: SUCCESS (6.364s)
[123.312747] Subtest perf: SUCCESS (21.161s)
[123.341785] [FACT i915_selftest (perf)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[123.342508] [FACT i915_selftest (perf)] deleted: kernel.kmod_is_loaded.i915: true
[123.345557] [026/134] (895s left) kms_async_flips (async-flip-with-page-flip-events-tiled)
[124.931798] Starting subtest: async-flip-with-page-flip-events-tiled
[125.303871] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs
[128.178976] Dynamic subtest pipe-A-eDP-1-4-rc-ccs: SUCCESS (2.820s)
[128.190064] Starting dynamic subtest: pipe-A-eDP-1-4
[130.374061] Dynamic subtest pipe-A-eDP-1-4: SUCCESS (2.196s)
[130.384785] Starting dynamic subtest: pipe-A-eDP-1-4
[132.332065] Dynamic subtest pipe-A-eDP-1-4: SUCCESS (2.009s)
[132.342201] Starting dynamic subtest: pipe-A-eDP-1-x
[134.562653] Dynamic subtest pipe-A-eDP-1-x: SUCCESS (2.178s)
[134.913552] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs
[137.704568] Dynamic subtest pipe-B-eDP-1-4-rc-ccs: SUCCESS (2.746s)
[137.716193] Starting dynamic subtest: pipe-B-eDP-1-4
[139.890859] Dynamic subtest pipe-B-eDP-1-4: SUCCESS (2.185s)
[139.901023] Starting dynamic subtest: pipe-B-eDP-1-4
[141.848730] Dynamic subtest pipe-B-eDP-1-4: SUCCESS (2.009s)
[141.856133] Starting dynamic subtest: pipe-B-eDP-1-x
[144.101764] Dynamic subtest pipe-B-eDP-1-x: SUCCESS (2.200s)
[144.413602] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs
[147.229180] Dynamic subtest pipe-C-eDP-1-4-rc-ccs: SUCCESS (2.768s)
[147.240948] Starting dynamic subtest: pipe-C-eDP-1-4
[149.404234] Dynamic subtest pipe-C-eDP-1-4: SUCCESS (2.174s)
[149.412475] Starting dynamic subtest: pipe-C-eDP-1-4
[151.362914] Dynamic subtest pipe-C-eDP-1-4: SUCCESS (2.010s)
[151.370286] Starting dynamic subtest: pipe-C-eDP-1-x
[153.582061] Dynamic subtest pipe-C-eDP-1-x: SUCCESS (2.166s)
[153.891669] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs
[156.616717] Dynamic subtest pipe-D-eDP-1-4-rc-ccs: SUCCESS (2.731s)
[156.626282] Starting dynamic subtest: pipe-D-eDP-1-4
[158.833658] Dynamic subtest pipe-D-eDP-1-4: SUCCESS (2.163s)
[158.843426] Starting dynamic subtest: pipe-D-eDP-1-4
[160.791449] Dynamic subtest pipe-D-eDP-1-4: SUCCESS (2.010s)
[160.798798] Starting dynamic subtest: pipe-D-eDP-1-x
[163.021634] Dynamic subtest pipe-D-eDP-1-x: SUCCESS (2.178s)
[163.024083] Subtest async-flip-with-page-flip-events-tiled: SUCCESS (38.037s)
[164.224330] [FACT kms_async_flips (async-flip-with-page-flip-events-tiled)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[164.226641] [FACT kms_async_flips (async-flip-with-page-flip-events-tiled)] new: kernel.kmod_is_loaded.i915: true
[164.231493] [027/134] (854s left) gem_userptr_blits (access-control)
[164.308869] Starting subtest: access-control
[164.313064] Subtest access-control: SKIP (0.000s)
[164.431134] [028/134] (854s left) kms_plane (pixel-format-4-tiled-modifier)
[164.529199] Starting subtest: pixel-format-4-tiled-modifier
[164.555088] Starting dynamic subtest: pipe-A-plane-0
[165.187686] Dynamic subtest pipe-A-plane-0: SUCCESS (0.633s)
[165.197178] Starting dynamic subtest: pipe-A-plane-3
[165.598878] Dynamic subtest pipe-A-plane-3: SUCCESS (0.411s)
[165.606940] Starting dynamic subtest: pipe-A-plane-5
[165.610548] Dynamic subtest pipe-A-plane-5: SKIP (0.000s)
[166.691934] Starting dynamic subtest: pipe-B-plane-0
[167.285063] Dynamic subtest pipe-B-plane-0: SUCCESS (0.600s)
[167.292473] Starting dynamic subtest: pipe-B-plane-3
[167.673674] Dynamic subtest pipe-B-plane-3: SUCCESS (0.388s)
[167.681171] Starting dynamic subtest: pipe-B-plane-5
[167.684764] Dynamic subtest pipe-B-plane-5: SKIP (0.000s)
[167.991571] Subtest pixel-format-4-tiled-modifier: SUCCESS (3.462s)
[168.879676] [029/134] (849s left) gem_exec_reloc (basic-wc-noreloc)
[168.939170] Subtest basic-wc-noreloc: SKIP (0.000s)
[169.029452] [030/134] (849s left) kms_pm_lpsp (kms-lpsp)
[170.130590] Starting subtest: kms-lpsp
[170.133055] Starting dynamic subtest: pipe-A-eDP-1
[170.284233] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.156s)
[170.578589] Subtest kms-lpsp: SUCCESS (0.451s)
[171.416266] [031/134] (847s left) gem_mmap_wc (read)
[171.488650] Subtest read: SKIP (0.000s)
[171.556439] [032/134] (847s left) kms_frontbuffer_tracking (psr-farfromfence-mmap-gtt)
[171.663617] Starting subtest: psr-farfromfence-mmap-gtt
[171.667761] Subtest psr-farfromfence-mmap-gtt: SKIP (0.000s)
[171.794404] [033/134] (846s left) gen9_exec_parse (bb-oversize)
[171.858999] Subtest bb-oversize: SKIP (0.000s)
[171.938988] [034/134] (846s left) gem_exec_reloc (basic-concurrent0)
[172.006682] Subtest basic-concurrent0: SKIP (0.000s)
[172.091591] [035/134] (846s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-fullscreen)
[172.181104] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-fullscreen
[178.912530] Subtest fbcpsr-1p-primscrn-spr-indfb-fullscreen: SUCCESS (6.734s)
[179.059168] [036/134] (839s left) gem_workarounds (reset)
[179.132692] Starting subtest: reset
[179.305150] Subtest reset: SUCCESS (0.175s)
[179.447275] [037/134] (839s left) syncobj_wait (invalid-single-wait-unsubmitted)
[179.516170] Starting subtest: invalid-single-wait-unsubmitted
[179.518408] Subtest invalid-single-wait-unsubmitted: SUCCESS (0.000s)
[179.638312] [038/134] (839s left) kms_big_fb (4-tiled-addfb-size-offset-overflow)
[179.737174] Starting subtest: 4-tiled-addfb-size-offset-overflow
[179.739552] Subtest 4-tiled-addfb-size-offset-overflow: SUCCESS (0.000s)
[179.871849] [039/134] (839s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-mmap-gtt)
[179.972219] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-mmap-gtt
[179.975786] Subtest fbc-2p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[180.096546] [040/134] (838s left) kms_rmfb (rmfb-ioctl)
[180.186512] Starting subtest: rmfb-ioctl
[180.188510] Starting dynamic subtest: pipe-A-eDP-1
[180.291314] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.106s)
[180.302166] Starting dynamic subtest: pipe-B-eDP-1
[181.506668] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.212s)
[181.515988] Starting dynamic subtest: pipe-C-eDP-1
[182.648157] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.140s)
[182.656176] Starting dynamic subtest: pipe-D-eDP-1
[183.775306] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.126s)
[183.777678] Subtest rmfb-ioctl: SUCCESS (3.590s)
[184.990505] [041/134] (833s left) perf_pmu (busy-accuracy-2)
[185.030898] Starting subtest: busy-accuracy-2
[185.033183] Starting dynamic subtest: rcs0
[188.077693] Dynamic subtest rcs0: SUCCESS (3.045s)
[188.087188] Starting dynamic subtest: bcs0
[191.194478] Dynamic subtest bcs0: SUCCESS (3.054s)
[191.204633] Starting dynamic subtest: vcs0
[194.230666] Dynamic subtest vcs0: SUCCESS (3.045s)
[194.240611] Starting dynamic subtest: vcs1
[197.279155] Dynamic subtest vcs1: SUCCESS (3.047s)
[197.288768] Starting dynamic subtest: vecs0
[200.329596] Dynamic subtest vecs0: SUCCESS (3.048s)
[200.339790] Starting dynamic subtest: ccs0
[203.385660] Dynamic subtest ccs0: SUCCESS (3.052s)
[203.388045] Subtest busy-accuracy-2: SUCCESS (18.304s)
[203.479447] [042/134] (815s left) kms_frontbuffer_tracking (fbc-1p-primscrn-indfb-plflip-blt)
[203.579670] Starting subtest: fbc-1p-primscrn-indfb-plflip-blt
[208.204499] Subtest fbc-1p-primscrn-indfb-plflip-blt: SUCCESS (4.629s)
[209.407439] [043/134] (809s left) syncobj_wait (single-wait-for-submit-submitted)
[209.472523] Starting subtest: single-wait-for-submit-submitted
[209.578029] Subtest single-wait-for-submit-submitted: SUCCESS (0.105s)
[209.676170] [044/134] (809s left) kms_ccs (crc-primary-basic-4-tiled-dg2-rc-ccs)
[209.785071] Starting subtest: crc-primary-basic-4-tiled-dg2-rc-ccs
[209.787282] Starting dynamic subtest: pipe-A-eDP-1
[209.809348] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[209.819278] Starting dynamic subtest: pipe-B-eDP-1
[209.840151] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[209.848440] Starting dynamic subtest: pipe-C-eDP-1
[209.869568] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[209.877908] Starting dynamic subtest: pipe-D-eDP-1
[209.898827] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[209.902652] Subtest crc-primary-basic-4-tiled-dg2-rc-ccs: SKIP (0.006s)
[211.954367] [045/134] (807s left) kms_content_protection (lic-type-1)
[212.107076] Starting subtest: lic-type-1
[212.111680] Subtest lic-type-1: SKIP (0.000s)
[212.264889] [046/134] (806s left) kms_pm_rpm (modeset-non-lpsp)
[214.092746] Starting subtest: modeset-non-lpsp
[215.241249] Subtest modeset-non-lpsp: SKIP (1.149s)
[215.635298] [047/134] (803s left) kms_flip_scaled_crc (flip-32bpp-yftile-to-64bpp-yftile-downscaling)
[215.733323] Starting subtest: flip-32bpp-yftile-to-64bpp-yftile-downscaling
[215.735474] Starting dynamic subtest: pipe-A-default-mode
[216.020873] Dynamic subtest pipe-A-default-mode: SKIP (0.286s)
[216.025237] Subtest flip-32bpp-yftile-to-64bpp-yftile-downscaling: SKIP (0.287s)
[216.858766] [048/134] (802s left) kms_psr (psr2-sprite-mmap-gtt)
[216.959981] Starting subtest: psr2-sprite-mmap-gtt
[216.962142] Starting dynamic subtest: eDP-1
[218.358661] Dynamic subtest eDP-1: SKIP (1.396s)
[218.363345] Subtest psr2-sprite-mmap-gtt: SKIP (1.398s)
[218.538566] [049/134] (800s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-render)
[218.647663] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-render
[218.651964] Subtest psr-2p-scndscrn-spr-indfb-draw-render: SKIP (0.000s)
[218.778871] [050/134] (800s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-render)
[218.871680] Starting subtest: fbcpsr-rgb101010-draw-render
[225.666760] Subtest fbcpsr-rgb101010-draw-render: SUCCESS (6.798s)
[225.811919] [051/134] (793s left) kms_feature_discovery (display-3x)
[225.911967] Starting subtest: display-3x
[225.916395] Subtest display-3x: SKIP (0.000s)
[225.996404] [052/134] (793s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-onoff)
[226.099759] Starting subtest: psr-2p-primscrn-cur-indfb-onoff
[226.103961] Subtest psr-2p-primscrn-cur-indfb-onoff: SKIP (0.000s)
[226.231047] [053/134] (793s left) kms_cursor_legacy (short-busy-flip-before-cursor-toggle)
[226.354548] Starting subtest: short-busy-flip-before-cursor-toggle
[226.359132] Subtest short-busy-flip-before-cursor-toggle: SKIP (0.000s)
[226.510262] [054/134] (792s left) kms_color (invalid-ctm-matrix-sizes)
[226.602362] Starting subtest: invalid-ctm-matrix-sizes
[226.604308] Starting dynamic subtest: pipe-A
[226.606080] Dynamic subtest pipe-A: SUCCESS (0.002s)
[226.614541] Starting dynamic subtest: pipe-B
[226.616552] Dynamic subtest pipe-B: SUCCESS (0.003s)
[226.624177] Starting dynamic subtest: pipe-C
[226.625955] Dynamic subtest pipe-C: SUCCESS (0.003s)
[226.633726] Starting dynamic subtest: pipe-D
[226.635327] Dynamic subtest pipe-D: SUCCESS (0.004s)
[226.636908] Subtest invalid-ctm-matrix-sizes: SUCCESS (0.014s)
[226.694868] [055/134] (792s left) gem_exec_balancer (sequential)
[226.764338] Starting subtest: sequential
[229.840494] Subtest sequential: SUCCESS (3.076s)
[230.184090] [056/134] (789s left) kms_big_fb (x-tiled-32bpp-rotate-0)
[230.290983] Starting subtest: x-tiled-32bpp-rotate-0
[231.780586] Subtest x-tiled-32bpp-rotate-0: SUCCESS (1.491s)
[231.949485] [057/134] (787s left) gem_exec_whisper (basic-contexts-all)
[232.014291] Starting subtest: basic-contexts-all
[243.896976] Subtest basic-contexts-all: SUCCESS (11.878s)
[244.092934] [058/134] (775s left) gem_render_copy (y-tiled-ccs-to-yf-tiled-mc-ccs)
[244.169786] Starting subtest: y-tiled-ccs-to-yf-tiled-mc-ccs
[244.174447] Subtest y-tiled-ccs-to-yf-tiled-mc-ccs: SKIP (0.000s)
[244.372321] [059/134] (775s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-mmap-cpu)
[244.467066] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-mmap-cpu
[251.508829] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-mmap-cpu: SUCCESS (7.045s)
[251.634536] [060/134] (768s left) kms_cursor_crc (cursor-sliding-64x21)
[251.851451] Starting subtest: cursor-sliding-64x21
[251.908024] Subtest cursor-sliding-64x21: SKIP (0.052s)
[252.176762] [061/134] (767s left) kms_rotation_crc (cursor-rotation-180)
[252.284067] Starting subtest: cursor-rotation-180
[253.825768] Subtest cursor-rotation-180: SUCCESS (1.542s)
[255.016894] [062/134] (764s left) kms_psr (fbc-pr-primary-mmap-gtt)
[255.117192] Starting subtest: fbc-pr-primary-mmap-gtt
[255.121711] Subtest fbc-pr-primary-mmap-gtt: SKIP (0.000s)
[255.199379] [063/134] (764s left) syncobj_timeline (wait-any-complex)
[255.262722] Starting subtest: wait-any-complex
[255.322651] Subtest wait-any-complex: SUCCESS (0.062s)
[255.409501] [064/134] (764s left) gem_exec_params (invalid-bsd2-flag-on-render)
[255.485068] Starting subtest: invalid-bsd2-flag-on-render
[255.487407] Subtest invalid-bsd2-flag-on-render: SUCCESS (0.000s)
[255.622575] [065/134] (764s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-180)
[255.719696] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-180
[255.724155] Subtest y-tiled-max-hw-stride-32bpp-rotate-180: SKIP (0.000s)
[255.846332] [066/134] (764s left) gem_exec_params (rel-constants-invalid-ring)
[255.908449] Starting subtest: rel-constants-invalid-ring
[255.910839] Subtest rel-constants-invalid-ring: SUCCESS (0.000s)
[256.029284] [067/134] (763s left) kms_cursor_legacy (cursor-vs-flip-atomic-transitions)
[256.147991] Starting subtest: cursor-vs-flip-atomic-transitions
[286.040614] Subtest cursor-vs-flip-atomic-transitions: SUCCESS (29.890s)
[286.856248] [068/134] (733s left) syncobj_timeline (multi-wait-all-available-submitted)
[286.917295] Starting subtest: multi-wait-all-available-submitted
[286.919571] Subtest multi-wait-all-available-submitted: SUCCESS (0.001s)
[287.035866] [069/134] (733s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-mmap-gtt)
[287.135162] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-mmap-gtt
[287.139219] Subtest fbc-2p-scndscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[287.260916] [070/134] (732s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-mmap-cpu)
[287.362327] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-mmap-cpu
[287.366623] Subtest fbc-2p-scndscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[287.461481] [071/134] (732s left) kms_flip (basic-flip-vs-modeset)
[287.555123] Starting subtest: basic-flip-vs-modeset
[287.557469] Starting dynamic subtest: A-eDP1
[290.148632] Dynamic subtest A-eDP1: SUCCESS (2.590s)
[290.157920] Starting dynamic subtest: B-eDP1
[292.318613] Dynamic subtest B-eDP1: SUCCESS (2.171s)
[292.332606] Starting dynamic subtest: C-eDP1
[294.485123] Dynamic subtest C-eDP1: SUCCESS (2.163s)
[294.494646] Starting dynamic subtest: D-eDP1
[296.657615] Dynamic subtest D-eDP1: SUCCESS (2.172s)
[296.659756] Subtest basic-flip-vs-modeset: SUCCESS (9.104s)
[297.467902] [072/134] (722s left) i915_drm_fdinfo (memory-info-shared)
[297.509138] Starting subtest: memory-info-shared
[297.511301] Starting dynamic subtest: smem0
[297.595897] Dynamic subtest smem0: SUCCESS (0.089s)
[297.598795] Subtest memory-info-shared: SUCCESS (0.090s)
[297.683195] [073/134] (722s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-pwrite)
[297.777868] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-pwrite
[303.997842] Subtest fbc-1p-primscrn-pri-shrfb-draw-pwrite: SUCCESS (6.222s)
[305.166051] [074/134] (715s left) prime_vgem (fence-wait)
[305.249992] Starting subtest: fence-wait
[305.252308] Starting dynamic subtest: rcs0
[306.318382] Dynamic subtest rcs0: SUCCESS (1.066s)
[306.330477] Starting dynamic subtest: bcs0
[307.397560] Dynamic subtest bcs0: SUCCESS (1.077s)
[307.408799] Starting dynamic subtest: vcs0
[308.451057] Dynamic subtest vcs0: SUCCESS (1.052s)
[308.462380] Starting dynamic subtest: vcs1
[309.490568] Dynamic subtest vcs1: SUCCESS (1.038s)
[309.501458] Starting dynamic subtest: vecs0
[310.532252] Dynamic subtest vecs0: SUCCESS (1.040s)
[310.543500] Starting dynamic subtest: ccs0
[311.576766] Dynamic subtest ccs0: SUCCESS (1.042s)
[311.579549] Subtest fence-wait: SUCCESS (6.326s)
[311.735894] [075/134] (708s left) gem_mmap_gtt (medium-copy)
[311.800763] Subtest medium-copy: SKIP (0.000s)
[311.866008] [076/134] (708s left) gem_exec_whisper (basic-sync)
[311.931975] Starting subtest: basic-sync
[322.212625] Subtest basic-sync: SUCCESS (10.257s)
[322.398955] [077/134] (697s left) kms_frontbuffer_tracking (psr-1p-primscrn-shrfb-msflip-blt)
[322.506116] Starting subtest: psr-1p-primscrn-shrfb-msflip-blt
[329.813497] Subtest psr-1p-primscrn-shrfb-msflip-blt: SUCCESS (7.310s)
[329.993662] [078/134] (690s left) gem_spin_batch (resubmit-new)
[330.070760] Starting subtest: resubmit-new
[330.073108] Starting dynamic subtest: rcs0
[330.079532] Dynamic subtest rcs0: SUCCESS (0.009s)
[330.089302] Starting dynamic subtest: bcs0
[330.091501] Dynamic subtest bcs0: SUCCESS (0.005s)
[330.100295] Starting dynamic subtest: vcs0
[330.102460] Dynamic subtest vcs0: SUCCESS (0.004s)
[330.110698] Starting dynamic subtest: vcs1
[330.112600] Dynamic subtest vcs1: SUCCESS (0.004s)
[330.120443] Starting dynamic subtest: vecs0
[330.122341] Dynamic subtest vecs0: SUCCESS (0.004s)
[330.130269] Starting dynamic subtest: ccs0
[330.132170] Dynamic subtest ccs0: SUCCESS (0.005s)
[330.134026] Subtest resubmit-new: SUCCESS (0.034s)
[331.912907] [079/134] (688s left) kms_pm_backlight (basic-brightness)
[332.005472] Starting subtest: basic-brightness
[332.053953] Starting dynamic subtest: eDP-1
[332.572936] Dynamic subtest eDP-1: SUCCESS (0.517s)
[332.575174] Subtest basic-brightness: SUCCESS (0.568s)
[333.454369] [080/134] (687s left) gem_ctx_exec (basic)
[333.526737] Starting subtest: basic
[333.532368] Subtest basic: SUCCESS (0.006s)
[333.676569] [081/134] (686s left) perf (disabled-read-error)
[333.815632] Starting subtest: disabled-read-error
[333.838071] Subtest disabled-read-error: SUCCESS (0.023s)
[333.879166] [082/134] (686s left) gem_pxp (verify-pxp-stale-ctx-execution)
[334.006751] Starting subtest: verify-pxp-stale-ctx-execution
[335.069825] Subtest verify-pxp-stale-ctx-execution: SUCCESS (1.061s)
[335.225411] [083/134] (685s left) kms_cursor_crc (cursor-sliding-128x128)
[335.440412] Starting subtest: cursor-sliding-128x128
[335.445190] Starting dynamic subtest: pipe-A-eDP-1
[338.692940] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.248s)
[338.721881] Starting dynamic subtest: pipe-D-eDP-1
[342.639624] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.922s)
[342.641949] Subtest cursor-sliding-128x128: SUCCESS (7.197s)
[343.529551] [084/134] (677s left) kms_flip_scaled_crc (flip-64bpp-yftile-to-16bpp-yftile-upscaling)
[343.625058] Starting subtest: flip-64bpp-yftile-to-16bpp-yftile-upscaling
[343.627314] Starting dynamic subtest: pipe-A-default-mode
[343.923674] Dynamic subtest pipe-A-default-mode: SKIP (0.295s)
[343.928445] Subtest flip-64bpp-yftile-to-16bpp-yftile-upscaling: SKIP (0.297s)
[344.751389] [085/134] (675s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-render)
[344.837924] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-render
[344.842094] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-render: SKIP (0.000s)
[344.964486] [086/134] (675s left) syncobj_wait (invalid-single-wait-all-unsubmitted)
[345.017966] Starting subtest: invalid-single-wait-all-unsubmitted
[345.020346] Subtest invalid-single-wait-all-unsubmitted: SUCCESS (0.000s)
[345.126570] [087/134] (675s left) kms_vblank (query-forked)
[345.224479] Starting subtest: query-forked
[345.226403] Starting dynamic subtest: pipe-A-eDP-1
[347.039443] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.813s)
[347.054063] Starting dynamic subtest: pipe-D-eDP-1
[349.525713] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.482s)
[349.528152] Subtest query-forked: SUCCESS (4.300s)
[350.404018] [088/134] (670s left) kms_ccs (crc-primary-rotation-180-yf-tiled-ccs)
[350.511525] Starting subtest: crc-primary-rotation-180-yf-tiled-ccs
[350.513870] Starting dynamic subtest: pipe-A-eDP-1
[350.537464] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[350.551335] Starting dynamic subtest: pipe-B-eDP-1
[350.573964] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[350.588530] Starting dynamic subtest: pipe-C-eDP-1
[350.610891] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[350.620977] Starting dynamic subtest: pipe-D-eDP-1
[350.643050] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[350.647106] Subtest crc-primary-rotation-180-yf-tiled-ccs: SKIP (0.006s)
[352.769359] [089/134] (668s left) kms_flip (plain-flip-fb-recreate)
[352.866803] Starting subtest: plain-flip-fb-recreate
[352.869088] Starting dynamic subtest: A-eDP1
[361.746783] Dynamic subtest A-eDP1: SUCCESS (8.882s)
[361.756379] Starting dynamic subtest: B-eDP1
[370.579898] Dynamic subtest B-eDP1: SUCCESS (8.831s)
[370.590329] Starting dynamic subtest: C-eDP1
[379.398464] Dynamic subtest C-eDP1: SUCCESS (8.816s)
[379.408124] Starting dynamic subtest: D-eDP1
[388.230568] Dynamic subtest D-eDP1: SUCCESS (8.831s)
[388.234971] Subtest plain-flip-fb-recreate: SUCCESS (35.371s)
[389.425390] [090/134] (631s left) kms_psr (pr-cursor-plane-move)
[389.509425] Starting subtest: pr-cursor-plane-move
[389.513554] Subtest pr-cursor-plane-move: SKIP (0.000s)
[389.595022] [091/134] (631s left) gem_exec_schedule (preempt-other-chain)
[389.678273] Starting subtest: preempt-other-chain
[389.680503] Starting dynamic subtest: rcs0
[389.761529] Dynamic subtest rcs0: SUCCESS (0.091s)
[389.782351] Starting dynamic subtest: bcs0
[389.842103] Dynamic subtest bcs0: SUCCESS (0.080s)
[389.856646] Starting dynamic subtest: vcs0
[389.922073] Dynamic subtest vcs0: SUCCESS (0.079s)
[389.931708] Starting dynamic subtest: vcs1
[390.011599] Dynamic subtest vcs1: SUCCESS (0.088s)
[390.021235] Starting dynamic subtest: vecs0
[390.089193] Dynamic subtest vecs0: SUCCESS (0.078s)
[390.104195] Starting dynamic subtest: ccs0
[390.167950] Dynamic subtest ccs0: SUCCESS (0.078s)
[390.170998] Subtest preempt-other-chain: SUCCESS (0.498s)
[391.053173] [092/134] (629s left) kms_ccs (random-ccs-data-4-tiled-bmg-ccs)
[391.153308] Starting subtest: random-ccs-data-4-tiled-bmg-ccs
[391.157837] Subtest random-ccs-data-4-tiled-bmg-ccs: SKIP (0.000s)
[392.259735] [093/134] (628s left) gem_flink_basic (basic)
[392.323542] Starting subtest: basic
[392.325471] Subtest basic: SUCCESS (0.000s)
[392.450075] [094/134] (628s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-onoff)
[392.551239] Starting subtest: fbc-2p-scndscrn-spr-indfb-onoff
[392.555193] Subtest fbc-2p-scndscrn-spr-indfb-onoff: SKIP (0.000s)
[392.672630] [095/134] (628s left) kms_vblank (wait-forked-busy)
[392.767331] Starting subtest: wait-forked-busy
[392.769545] Starting dynamic subtest: pipe-A-eDP-1
[394.639726] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.873s)
[394.653865] Starting dynamic subtest: pipe-D-eDP-1
[397.219074] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.576s)
[397.221223] Subtest wait-forked-busy: SUCCESS (4.452s)
[398.037162] [096/134] (623s left) core_getversion (basic)
[398.072185] Starting subtest: basic
[398.076696] Subtest basic: SUCCESS (0.000s)
[398.150633] [097/134] (623s left) kms_big_fb (linear-32bpp-rotate-0)
[398.248413] Starting subtest: linear-32bpp-rotate-0
[399.793507] Subtest linear-32bpp-rotate-0: SUCCESS (1.545s)
[399.963290] [098/134] (621s left) kms_big_fb (yf-tiled-32bpp-rotate-270)
[400.068453] Starting subtest: yf-tiled-32bpp-rotate-270
[400.071986] Subtest yf-tiled-32bpp-rotate-270: SKIP (0.000s)
[400.191767] [099/134] (621s left) kms_flip_scaled_crc (flip-nv12-linear-to-nv12-linear-reflect-x)
[400.294508] Starting subtest: flip-NV12-linear-to-NV12-linear-reflect-x
[400.296308] Starting dynamic subtest: pipe-A-default-mode
[401.484451] Dynamic subtest pipe-A-default-mode: SKIP (1.186s)
[401.488556] Subtest flip-NV12-linear-to-NV12-linear-reflect-x: SKIP (1.187s)
[401.665340] [100/134] (619s left) kms_addfb_basic (invalid-get-prop)
[401.726646] Starting subtest: invalid-get-prop
[401.728914] Subtest invalid-get-prop: SUCCESS (0.000s)
[401.876242] [101/134] (619s left) gem_mmap_offset (partial-unmap)
[401.932046] Starting subtest: partial-unmap
[401.933933] Starting dynamic subtest: smem0
[402.402842] Dynamic subtest smem0: SUCCESS (0.471s)
[402.405738] Subtest partial-unmap: SUCCESS (0.472s)
[402.523797] [102/134] (618s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-blt)
[402.617861] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-blt
[402.622136] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[402.746032] [103/134] (618s left) gem_mmap_gtt (basic)
[402.805642] Subtest basic: SKIP (0.000s)
[402.871245] [104/134] (618s left) syncobj_timeline (etime-multi-wait-all-available-unsubmitted)
[402.921486] Starting subtest: etime-multi-wait-all-available-unsubmitted
[403.025721] Subtest etime-multi-wait-all-available-unsubmitted: SUCCESS (0.105s)
[403.113904] [105/134] (618s left) gem_busy (busy)
[403.180032] Starting subtest: busy
[403.182435] Starting dynamic subtest: all-engines
[403.246821] Dynamic subtest all-engines: SUCCESS (0.066s)
[403.258276] Starting dynamic subtest: rcs0
[404.893916] Dynamic subtest rcs0: SUCCESS (1.645s)
[404.903747] Starting dynamic subtest: bcs0
[404.959760] Dynamic subtest bcs0: SUCCESS (0.063s)
[404.969357] Starting dynamic subtest: vcs0
[404.998231] Dynamic subtest vcs0: SUCCESS (0.038s)
[405.007081] Starting dynamic subtest: vcs1
[406.939066] Dynamic subtest vcs1: SUCCESS (1.939s)
[406.950066] Starting dynamic subtest: vecs0
[408.980662] Dynamic subtest vecs0: SUCCESS (1.981s)
[408.991515] Starting dynamic subtest: ccs0
[410.907893] Dynamic subtest ccs0: SUCCESS (1.983s)
[410.910205] Subtest busy: SUCCESS (7.724s)
[411.293969] [106/134] (610s left) kms_invalid_mode (bad-hsync-start)
[411.386777] Starting subtest: bad-hsync-start
[411.389047] Starting dynamic subtest: pipe-A-eDP-1
[411.675294] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.290s)
[411.683718] Starting dynamic subtest: pipe-B-eDP-1
[411.685587] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[411.693703] Starting dynamic subtest: pipe-C-eDP-1
[411.695611] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[411.703756] Starting dynamic subtest: pipe-D-eDP-1
[411.705852] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[411.707998] Subtest bad-hsync-start: SUCCESS (0.296s)
[412.485357] [107/134] (609s left) kms_plane (pixel-format-y-tiled-gen12-rc-ccs-cc-modifier-source-clamping)
[412.594197] Starting subtest: pixel-format-y-tiled-gen12-rc-ccs-cc-modifier-source-clamping
[412.620879] Starting dynamic subtest: pipe-A-plane-0
[412.624951] Dynamic subtest pipe-A-plane-0: SKIP (0.000s)
[412.634154] Starting dynamic subtest: pipe-A-plane-3
[412.638711] Dynamic subtest pipe-A-plane-3: SKIP (0.000s)
[412.647227] Starting dynamic subtest: pipe-A-plane-5
[412.651534] Dynamic subtest pipe-A-plane-5: SKIP (0.000s)
[413.764340] Starting dynamic subtest: pipe-B-plane-0
[413.768798] Dynamic subtest pipe-B-plane-0: SKIP (0.000s)
[413.777556] Starting dynamic subtest: pipe-B-plane-3
[413.782163] Dynamic subtest pipe-B-plane-3: SKIP (0.000s)
[413.790801] Starting dynamic subtest: pipe-B-plane-5
[413.795066] Dynamic subtest pipe-B-plane-5: SKIP (0.000s)
[414.089839] Subtest pixel-format-y-tiled-gen12-rc-ccs-cc-modifier-source-clamping: SKIP (1.494s)
[414.949990] [108/134] (606s left) gem_exec_create (basic)
[415.016728] Starting subtest: basic
[415.019157] Starting dynamic subtest: smem
[418.901761] Dynamic subtest smem: SUCCESS (3.882s)
[418.904716] Subtest basic: SUCCESS (3.884s)
[419.102889] [109/134] (602s left) kms_big_fb (y-tiled-64bpp-rotate-90)
[419.211884] Starting subtest: y-tiled-64bpp-rotate-90
[419.216596] Subtest y-tiled-64bpp-rotate-90: SKIP (0.000s)
[419.338228] [110/134] (602s left) gem_ctx_persistence (engines-mixed-process)
[419.390661] Starting subtest: engines-mixed-process
[419.393062] Starting dynamic subtest: rcs0
[420.911075] Dynamic subtest rcs0: SUCCESS (1.520s)
[420.923188] Starting dynamic subtest: bcs0
[422.869897] Dynamic subtest bcs0: SUCCESS (1.957s)
[422.879094] Starting dynamic subtest: vcs0
[424.888865] Dynamic subtest vcs0: SUCCESS (2.018s)
[424.900886] Starting dynamic subtest: vcs1
[426.935030] Dynamic subtest vcs1: SUCCESS (2.044s)
[426.946303] Starting dynamic subtest: vecs0
[428.891204] Dynamic subtest vecs0: SUCCESS (1.954s)
[428.901404] Starting dynamic subtest: ccs0
[430.866908] Dynamic subtest ccs0: SUCCESS (1.974s)
[430.869408] Subtest engines-mixed-process: SUCCESS (11.476s)
[430.957844] [111/134] (590s left) perf_pmu (idle-no-semaphores)
[430.995995] Starting subtest: idle-no-semaphores
[430.998335] Starting dynamic subtest: rcs0
[431.540762] Dynamic subtest rcs0: SUCCESS (0.545s)
[431.552678] Starting dynamic subtest: bcs0
[432.064397] Dynamic subtest bcs0: SUCCESS (0.521s)
[432.076082] Starting dynamic subtest: vcs0
[432.588537] Dynamic subtest vcs0: SUCCESS (0.521s)
[432.600983] Starting dynamic subtest: vcs1
[433.109413] Dynamic subtest vcs1: SUCCESS (0.518s)
[433.121060] Starting dynamic subtest: vecs0
[433.634600] Dynamic subtest vecs0: SUCCESS (0.522s)
[433.646085] Starting dynamic subtest: ccs0
[434.158679] Dynamic subtest ccs0: SUCCESS (0.521s)
[434.161636] Subtest idle-no-semaphores: SUCCESS (3.166s)
[434.279435] [112/134] (587s left) gem_ctx_engines (execute-oneforall)
[434.362506] Starting subtest: execute-oneforall
[435.624724] Subtest execute-oneforall: SUCCESS (1.261s)
[435.991108] [113/134] (585s left) kms_properties (plane-properties-legacy)
[436.101985] Starting subtest: plane-properties-legacy
[436.104205] Starting dynamic subtest: pipe-A-eDP-1
[436.648122] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.545s)
[436.657588] Starting dynamic subtest: pipe-B-eDP-1
[437.913103] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.265s)
[437.925298] Starting dynamic subtest: pipe-C-eDP-1
[439.147507] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.233s)
[439.157502] Starting dynamic subtest: pipe-D-eDP-1
[440.374685] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.226s)
[440.377070] Subtest plane-properties-legacy: SUCCESS (4.275s)
[441.185911] [114/134] (580s left) gem_ctx_persistence (heartbeat-many)
[441.252780] Starting subtest: heartbeat-many
[441.257436] Subtest heartbeat-many: SKIP (0.000s)
[441.385515] [115/134] (580s left) gem_exec_fence (nb-await)
[441.570984] Starting subtest: nb-await
[441.573686] Starting dynamic subtest: rcs0
[441.639032] Dynamic subtest rcs0: SUCCESS (0.068s)
[441.651179] Starting dynamic subtest: bcs0
[441.696884] Dynamic subtest bcs0: SUCCESS (0.056s)
[441.708638] Starting dynamic subtest: vcs0
[441.755861] Dynamic subtest vcs0: SUCCESS (0.057s)
[441.767044] Starting dynamic subtest: vcs1
[441.814784] Dynamic subtest vcs1: SUCCESS (0.057s)
[441.825439] Starting dynamic subtest: vecs0
[441.873834] Dynamic subtest vecs0: SUCCESS (0.057s)
[441.885485] Starting dynamic subtest: ccs0
[441.932232] Dynamic subtest ccs0: SUCCESS (0.056s)
[441.934951] Subtest nb-await: SUCCESS (0.362s)
[444.040356] [116/134] (577s left) gem_exec_flush (basic-uc-rw-default)
[444.103494] Starting subtest: basic-uc-rw-default
[449.592450] Subtest basic-uc-rw-default: SUCCESS (5.462s)
[449.780171] [117/134] (572s left) gem_userptr_blits (map-fixed-invalidate-overlap)
[449.847059] Starting subtest: map-fixed-invalidate-overlap
[449.851456] Subtest map-fixed-invalidate-overlap: SKIP (0.000s)
[450.008632] [118/134] (572s left) kms_lease (lease-invalid-plane)
[450.109673] Starting subtest: lease-invalid-plane
[450.111794] Starting dynamic subtest: pipe-A-eDP-1
[450.114019] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s)
[450.123117] Starting dynamic subtest: pipe-B-eDP-1
[450.125227] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[450.133645] Starting dynamic subtest: pipe-C-eDP-1
[450.135521] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[450.144267] Starting dynamic subtest: pipe-D-eDP-1
[450.146457] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[450.148582] Subtest lease-invalid-plane: SUCCESS (0.004s)
[450.206831] [119/134] (571s left) kms_psr2_sf (pr-cursor-plane-move-continuous-exceed-sf)
[455.241225] Starting subtest: pr-cursor-plane-move-continuous-exceed-sf
[455.246167] Subtest pr-cursor-plane-move-continuous-exceed-sf: SKIP (0.002s)
[456.110720] [120/134] (566s left) kms_ccs (random-ccs-data-y-tiled-ccs)
[456.199399] Starting subtest: random-ccs-data-y-tiled-ccs
[456.201592] Starting dynamic subtest: pipe-A-eDP-1
[456.226332] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[456.236799] Starting dynamic subtest: pipe-B-eDP-1
[456.259233] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[456.267866] Starting dynamic subtest: pipe-C-eDP-1
[456.290649] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[456.300114] Starting dynamic subtest: pipe-D-eDP-1
[456.325308] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[456.329623] Subtest random-ccs-data-y-tiled-ccs: SKIP (0.004s)
[458.475120] [121/134] (563s left) gem_exec_balancer (full-late)
[458.538220] Starting subtest: full-late
[462.745471] Subtest full-late: SUCCESS (4.210s)
[463.101101] [122/134] (559s left) api_intel_bb (intel-bb-blit-y)
[463.163739] Starting subtest: intel-bb-blit-y
[466.627456] Subtest intel-bb-blit-y: SUCCESS (3.462s)
[466.792775] [123/134] (555s left) kms_rotation_crc (primary-yf-tiled-reflect-x-180)
[466.897071] Starting subtest: primary-yf-tiled-reflect-x-180
[466.959584] Subtest primary-yf-tiled-reflect-x-180: SKIP (0.059s)
[467.068125] [124/134] (555s left) kms_cursor_legacy (2x-long-cursor-vs-flip-legacy)
[467.193660] Starting subtest: 2x-long-cursor-vs-flip-legacy
[467.198291] Subtest 2x-long-cursor-vs-flip-legacy: SKIP (0.001s)
[467.353268] [125/134] (554s left) kms_psr (fbc-psr2-suspend)
[467.450426] Starting subtest: fbc-psr2-suspend
[467.452323] Starting dynamic subtest: eDP-1
[467.456269] Dynamic subtest eDP-1: SKIP (0.000s)
[467.460238] Subtest fbc-psr2-suspend: SKIP (0.001s)
[467.534030] [126/134] (554s left) kms_psr (fbc-psr2-sprite-plane-onoff)
[467.629946] Starting subtest: fbc-psr2-sprite-plane-onoff
[467.632255] Starting dynamic subtest: eDP-1
[467.636274] Dynamic subtest eDP-1: SKIP (0.000s)
[467.639968] Subtest fbc-psr2-sprite-plane-onoff: SKIP (0.001s)
[467.713661] [127/134] (554s left) i915_pm_rps (min-max-config-idle)
[467.776909] Starting subtest: min-max-config-idle
[467.780855] Subtest min-max-config-idle: SKIP (0.001s)
[467.897857] [128/134] (554s left) sysfs_preempt_timeout (invalid)
[467.957257] Starting subtest: invalid
[467.959453] Starting dynamic subtest: vecs0
[467.961385] Dynamic subtest vecs0: SUCCESS (0.000s)
[467.971740] Starting dynamic subtest: ccs0
[467.973486] Dynamic subtest ccs0: SUCCESS (0.000s)
[467.981971] Starting dynamic subtest: vcs0
[467.983750] Dynamic subtest vcs0: SUCCESS (0.000s)
[467.991914] Starting dynamic subtest: bcs0
[467.993692] Dynamic subtest bcs0: SUCCESS (0.000s)
[468.001800] Starting dynamic subtest: rcs0
[468.003605] Dynamic subtest rcs0: SUCCESS (0.000s)
[468.011794] Starting dynamic subtest: vcs1
[468.013748] Dynamic subtest vcs1: SUCCESS (0.000s)
[468.015588] Subtest invalid: SUCCESS (0.005s)
[468.080043] [129/134] (554s left) gem_eio (create)
[468.303378] Starting subtest: create
[468.635112] Subtest create: SUCCESS (0.331s)
[468.796172] [130/134] (553s left) syncobj_timeline (etime-multi-wait-for-submit-submitted)
[468.854435] Starting subtest: etime-multi-wait-for-submit-submitted
[468.961903] Subtest etime-multi-wait-for-submit-submitted: SUCCESS (0.106s)
[469.051885] [131/134] (553s left) gem_mmap_gtt (cpuset-big-copy-xy)
[469.121092] Subtest cpuset-big-copy-XY: SKIP (0.000s)
[469.195899] [132/134] (553s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-blt)
[469.306159] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-blt
[476.120830] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-blt: SUCCESS (6.816s)
[476.306009] [133/134] (546s left) gem_exec_schedule (u-fairslice-all)
[476.379487] Starting subtest: u-fairslice-all
[478.493502] Subtest u-fairslice-all: SUCCESS (2.066s)
[478.769781] [134/134] (543s left) gem_vm_create (execbuf)
[478.828332] Starting subtest: execbuf
[478.838371] Subtest execbuf: SUCCESS (0.013s)
[479.002425] Closing watchdogs
results: parsing output: 0/ for test: kms_frontbuffer_tracking
results: parsing output: 1/ for test: kms_chamelium_frames
results: parsing output: 2/ for test: kms_ccs
results: parsing output: 3/ for test: kms_prop_blob
results: parsing output: 4/ for test: syncobj_wait
results: parsing output: 5/ for test: kms_frontbuffer_tracking
results: parsing output: 6/ for test: i915_module_load
results: parsing output: 7/ for test: syncobj_timeline
results: parsing output: 8/ for test: kms_big_fb
results: parsing output: 9/ for test: kms_frontbuffer_tracking
results: parsing output: 10/ for test: gem_partial_pwrite_pread
results: parsing output: 11/ for test: api_intel_allocator
results: parsing output: 12/ for test: syncobj_wait
results: parsing output: 13/ for test: kms_atomic
results: parsing output: 14/ for test: kms_psr
results: parsing output: 15/ for test: gem_tiled_blits
results: parsing output: 16/ for test: gem_flink_basic
results: parsing output: 17/ for test: kms_cursor_crc
results: parsing output: 18/ for test: kms_plane_scaling
results: parsing output: 19/ for test: gem_pxp
results: parsing output: 20/ for test: kms_plane_alpha_blend
results: parsing output: 21/ for test: kms_chamelium_hpd
results: parsing output: 22/ for test: gem_eio
results: parsing output: 23/ for test: kms_frontbuffer_tracking
results: parsing output: 24/ for test: i915_selftest
results: parsing output: 25/ for test: kms_async_flips
results: parsing output: 26/ for test: gem_userptr_blits
results: parsing output: 27/ for test: kms_plane
results: parsing output: 28/ for test: gem_exec_reloc
results: parsing output: 29/ for test: kms_pm_lpsp
results: parsing output: 30/ for test: gem_mmap_wc
results: parsing output: 31/ for test: kms_frontbuffer_tracking
results: parsing output: 32/ for test: gen9_exec_parse
results: parsing output: 33/ for test: gem_exec_reloc
results: parsing output: 34/ for test: kms_frontbuffer_tracking
results: parsing output: 35/ for test: gem_workarounds
results: parsing output: 36/ for test: syncobj_wait
results: parsing output: 37/ for test: kms_big_fb
results: parsing output: 38/ for test: kms_frontbuffer_tracking
results: parsing output: 39/ for test: kms_rmfb
results: parsing output: 40/ for test: perf_pmu
results: parsing output: 41/ for test: kms_frontbuffer_tracking
results: parsing output: 42/ for test: syncobj_wait
results: parsing output: 43/ for test: kms_ccs
results: parsing output: 44/ for test: kms_content_protection
results: parsing output: 45/ for test: kms_pm_rpm
results: parsing output: 46/ for test: kms_flip_scaled_crc
results: parsing output: 47/ for test: kms_psr
results: parsing output: 48/ for test: kms_frontbuffer_tracking
results: parsing output: 49/ for test: kms_frontbuffer_tracking
results: parsing output: 50/ for test: kms_feature_discovery
results: parsing output: 51/ for test: kms_frontbuffer_tracking
results: parsing output: 52/ for test: kms_cursor_legacy
results: parsing output: 53/ for test: kms_color
results: parsing output: 54/ for test: gem_exec_balancer
results: parsing output: 55/ for test: kms_big_fb
results: parsing output: 56/ for test: gem_exec_whisper
results: parsing output: 57/ for test: gem_render_copy
results: parsing output: 58/ for test: kms_frontbuffer_tracking
results: parsing output: 59/ for test: kms_cursor_crc
results: parsing output: 60/ for test: kms_rotation_crc
results: parsing output: 61/ for test: kms_psr
results: parsing output: 62/ for test: syncobj_timeline
results: parsing output: 63/ for test: gem_exec_params
results: parsing output: 64/ for test: kms_big_fb
results: parsing output: 65/ for test: gem_exec_params
results: parsing output: 66/ for test: kms_cursor_legacy
results: parsing output: 67/ for test: syncobj_timeline
results: parsing output: 68/ for test: kms_frontbuffer_tracking
results: parsing output: 69/ for test: kms_frontbuffer_tracking
results: parsing output: 70/ for test: kms_flip
results: parsing output: 71/ for test: i915_drm_fdinfo
results: parsing output: 72/ for test: kms_frontbuffer_tracking
results: parsing output: 73/ for test: prime_vgem
results: parsing output: 74/ for test: gem_mmap_gtt
results: parsing output: 75/ for test: gem_exec_whisper
results: parsing output: 76/ for test: kms_frontbuffer_tracking
results: parsing output: 77/ for test: gem_spin_batch
results: parsing output: 78/ for test: kms_pm_backlight
results: parsing output: 79/ for test: gem_ctx_exec
results: parsing output: 80/ for test: perf
results: parsing output: 81/ for test: gem_pxp
results: parsing output: 82/ for test: kms_cursor_crc
results: parsing output: 83/ for test: kms_flip_scaled_crc
results: parsing output: 84/ for test: kms_frontbuffer_tracking
results: parsing output: 85/ for test: syncobj_wait
results: parsing output: 86/ for test: kms_vblank
results: parsing output: 87/ for test: kms_ccs
results: parsing output: 88/ for test: kms_flip
results: parsing output: 89/ for test: kms_psr
results: parsing output: 90/ for test: gem_exec_schedule
results: parsing output: 91/ for test: kms_ccs
results: parsing output: 92/ for test: gem_flink_basic
results: parsing output: 93/ for test: kms_frontbuffer_tracking
results: parsing output: 94/ for test: kms_vblank
results: parsing output: 95/ for test: core_getversion
results: parsing output: 96/ for test: kms_big_fb
results: parsing output: 97/ for test: kms_big_fb
results: parsing output: 98/ for test: kms_flip_scaled_crc
results: parsing output: 99/ for test: kms_addfb_basic
results: parsing output: 100/ for test: gem_mmap_offset
results: parsing output: 101/ for test: kms_frontbuffer_tracking
results: parsing output: 102/ for test: gem_mmap_gtt
results: parsing output: 103/ for test: syncobj_timeline
results: parsing output: 104/ for test: gem_busy
results: parsing output: 105/ for test: kms_invalid_mode
results: parsing output: 106/ for test: kms_plane
results: parsing output: 107/ for test: gem_exec_create
results: parsing output: 108/ for test: kms_big_fb
results: parsing output: 109/ for test: gem_ctx_persistence
results: parsing output: 110/ for test: perf_pmu
results: parsing output: 111/ for test: gem_ctx_engines
results: parsing output: 112/ for test: kms_properties
results: parsing output: 113/ for test: gem_ctx_persistence
results: parsing output: 114/ for test: gem_exec_fence
results: parsing output: 115/ for test: gem_exec_flush
results: parsing output: 116/ for test: gem_userptr_blits
results: parsing output: 117/ for test: kms_lease
results: parsing output: 118/ for test: kms_psr2_sf
results: parsing output: 119/ for test: kms_ccs
results: parsing output: 120/ for test: gem_exec_balancer
results: parsing output: 121/ for test: api_intel_bb
results: parsing output: 122/ for test: kms_rotation_crc
results: parsing output: 123/ for test: kms_cursor_legacy
results: parsing output: 124/ for test: kms_psr
results: parsing output: 125/ for test: kms_psr
results: parsing output: 126/ for test: i915_pm_rps
results: parsing output: 127/ for test: sysfs_preempt_timeout
results: parsing output: 128/ for test: gem_eio
results: parsing output: 129/ for test: syncobj_timeline
results: parsing output: 130/ for test: gem_mmap_gtt
results: parsing output: 131/ for test: kms_frontbuffer_tracking
results: parsing output: 132/ for test: gem_exec_schedule
results: parsing output: 133/ for test: gem_vm_create
Done.